2025-08-25 21:45:34.871398 | Job console starting 2025-08-25 21:45:34.910072 | Updating git repos 2025-08-25 21:45:35.001305 | Cloning repos into workspace 2025-08-25 21:45:35.062291 | Restoring repo states 2025-08-25 21:45:35.075415 | Merging changes 2025-08-25 21:45:35.724544 | Checking out repos 2025-08-25 21:45:35.860942 | Preparing playbooks 2025-08-25 21:45:36.724208 | Running Ansible setup 2025-08-25 21:45:42.002887 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-25 21:45:43.198607 | 2025-08-25 21:45:43.198779 | PLAY [Base pre] 2025-08-25 21:45:43.233369 | 2025-08-25 21:45:43.233544 | TASK [Setup log path fact] 2025-08-25 21:45:43.265030 | debian-bookworm | ok 2025-08-25 21:45:43.282701 | 2025-08-25 21:45:43.282932 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-25 21:45:43.324799 | debian-bookworm | ok 2025-08-25 21:45:43.334869 | 2025-08-25 21:45:43.334996 | TASK [emit-job-header : Print job information] 2025-08-25 21:45:43.395184 | # Job Information 2025-08-25 21:45:43.395381 | Ansible Version: 2.16.14 2025-08-25 21:45:43.395415 | Job: python-black 2025-08-25 21:45:43.395447 | Pipeline: check 2025-08-25 21:45:43.395469 | Executor: 521e9411259a 2025-08-25 21:45:43.395490 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1918 2025-08-25 21:45:43.395513 | Event ID: cdf088c0-81fc-11f0-95f4-81e43adb9d45 2025-08-25 21:45:43.401200 | 2025-08-25 21:45:43.401331 | LOOP [emit-job-header : Print node information] 2025-08-25 21:45:43.521598 | debian-bookworm | ok: 2025-08-25 21:45:43.521881 | debian-bookworm | # Node Information 2025-08-25 21:45:43.521919 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-25 21:45:43.521945 | debian-bookworm | Hostname: debian 2025-08-25 21:45:43.521966 | debian-bookworm | Username: zuul 2025-08-25 21:45:43.521986 | debian-bookworm | Distro: Debian 12.11 2025-08-25 21:45:43.522009 | debian-bookworm | Provider: regiocloud-a 2025-08-25 21:45:43.522030 | debian-bookworm | Region: 2025-08-25 21:45:43.522052 | debian-bookworm | Label: debian-bookworm 2025-08-25 21:45:43.522072 | debian-bookworm | Product Name: OpenStack Nova 2025-08-25 21:45:43.522092 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:94a 2025-08-25 21:45:43.546230 | 2025-08-25 21:45:43.546391 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-25 21:45:44.273884 | debian-bookworm -> localhost | changed 2025-08-25 21:45:44.282526 | 2025-08-25 21:45:44.282658 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-25 21:45:45.536033 | debian-bookworm -> localhost | changed 2025-08-25 21:45:45.547513 | 2025-08-25 21:45:45.547611 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-25 21:45:45.979901 | debian-bookworm -> localhost | ok 2025-08-25 21:45:45.984945 | 2025-08-25 21:45:45.985031 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-25 21:45:46.001626 | debian-bookworm | ok 2025-08-25 21:45:46.015951 | debian-bookworm | included: /var/lib/zuul/builds/75920b0b1f9e47ecb33f90e3fe7b9441/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-25 21:45:46.026896 | 2025-08-25 21:45:46.026973 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-25 21:45:48.909149 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-25 21:45:48.909348 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/75920b0b1f9e47ecb33f90e3fe7b9441/work/75920b0b1f9e47ecb33f90e3fe7b9441_id_rsa 2025-08-25 21:45:48.909382 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/75920b0b1f9e47ecb33f90e3fe7b9441/work/75920b0b1f9e47ecb33f90e3fe7b9441_id_rsa.pub 2025-08-25 21:45:48.909404 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-25 21:45:48.909424 | debian-bookworm -> localhost | SHA256:ZjJ0jaVxKkQqHgaIep5BFeHKc+ASdDq+9sE46h9U6jg zuul-build-sshkey 2025-08-25 21:45:48.909442 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-25 21:45:48.909467 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-25 21:45:48.909486 | debian-bookworm -> localhost | |+. o++o . o | 2025-08-25 21:45:48.909504 | debian-bookworm -> localhost | |+.+. o O | 2025-08-25 21:45:48.909520 | debian-bookworm -> localhost | |o+= o.o = . | 2025-08-25 21:45:48.909537 | debian-bookworm -> localhost | |o*+=o. o | 2025-08-25 21:45:48.909554 | debian-bookworm -> localhost | |.+*=. o S | 2025-08-25 21:45:48.909575 | debian-bookworm -> localhost | | .Xo = | 2025-08-25 21:45:48.909592 | debian-bookworm -> localhost | | E = | 2025-08-25 21:45:48.909608 | debian-bookworm -> localhost | |o + o | 2025-08-25 21:45:48.909624 | debian-bookworm -> localhost | |o..o | 2025-08-25 21:45:48.909640 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-25 21:45:48.909681 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.342892 2025-08-25 21:45:48.915310 | 2025-08-25 21:45:48.915396 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-25 21:45:48.932060 | debian-bookworm | ok 2025-08-25 21:45:48.941425 | debian-bookworm | included: /var/lib/zuul/builds/75920b0b1f9e47ecb33f90e3fe7b9441/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-25 21:45:48.953893 | 2025-08-25 21:45:48.953984 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-25 21:45:48.986758 | debian-bookworm | skipping: Conditional result was False 2025-08-25 21:45:48.993259 | 2025-08-25 21:45:48.993347 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-25 21:45:49.646470 | debian-bookworm | changed 2025-08-25 21:45:49.655796 | 2025-08-25 21:45:49.655931 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-25 21:45:49.941039 | debian-bookworm | ok 2025-08-25 21:45:49.950199 | 2025-08-25 21:45:49.950322 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-25 21:45:50.610328 | debian-bookworm | changed 2025-08-25 21:45:50.624946 | 2025-08-25 21:45:50.625090 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-25 21:45:51.308534 | debian-bookworm | changed 2025-08-25 21:45:51.316789 | 2025-08-25 21:45:51.316881 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-25 21:45:51.339657 | debian-bookworm | skipping: Conditional result was False 2025-08-25 21:45:51.345325 | 2025-08-25 21:45:51.345417 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-25 21:45:51.894069 | debian-bookworm -> localhost | changed 2025-08-25 21:45:51.905302 | 2025-08-25 21:45:51.905405 | TASK [add-build-sshkey : Add back temp key] 2025-08-25 21:45:52.203954 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/75920b0b1f9e47ecb33f90e3fe7b9441/work/75920b0b1f9e47ecb33f90e3fe7b9441_id_rsa (zuul-build-sshkey) 2025-08-25 21:45:52.204189 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010775 2025-08-25 21:45:52.213304 | 2025-08-25 21:45:52.213402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-25 21:45:52.584604 | debian-bookworm | ok 2025-08-25 21:45:52.616757 | 2025-08-25 21:45:52.616927 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-25 21:45:52.661451 | debian-bookworm | skipping: Conditional result was False 2025-08-25 21:45:52.693317 | 2025-08-25 21:45:52.693465 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-25 21:45:53.227739 | debian-bookworm | ok 2025-08-25 21:45:53.244325 | 2025-08-25 21:45:53.244489 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-25 21:45:53.280399 | debian-bookworm | ok 2025-08-25 21:45:53.288863 | 2025-08-25 21:45:53.288993 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-25 21:45:53.609953 | debian-bookworm -> localhost | ok 2025-08-25 21:45:53.617697 | 2025-08-25 21:45:53.617822 | TASK [validate-host : Collect information about the host] 2025-08-25 21:45:54.774743 | debian-bookworm | ok 2025-08-25 21:45:54.788079 | 2025-08-25 21:45:54.788312 | TASK [validate-host : Sanitize hostname] 2025-08-25 21:45:54.932110 | debian-bookworm | ok 2025-08-25 21:45:54.990248 | 2025-08-25 21:45:54.990410 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-25 21:45:55.733033 | debian-bookworm -> localhost | changed 2025-08-25 21:45:55.739070 | 2025-08-25 21:45:55.739229 | TASK [validate-host : Collect information about zuul worker] 2025-08-25 21:45:56.214530 | debian-bookworm | ok 2025-08-25 21:45:56.227712 | 2025-08-25 21:45:56.227850 | TASK [validate-host : Write out all zuul information for each host] 2025-08-25 21:45:56.981865 | debian-bookworm -> localhost | changed 2025-08-25 21:45:57.000044 | 2025-08-25 21:45:57.000235 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-25 21:45:57.275193 | debian-bookworm | ok 2025-08-25 21:45:57.287046 | 2025-08-25 21:45:57.287209 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-25 21:45:58.721343 | debian-bookworm | changed: 2025-08-25 21:45:58.721581 | debian-bookworm | cd+++++++++ src/ 2025-08-25 21:45:58.721617 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-25 21:45:58.721642 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-25 21:45:58.721664 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-08-25 21:45:58.721685 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007489 2025-08-25 21:46:25.410489 | 2025-08-25 21:46:25.410691 | TASK [upload-logs : Upload logs to log server] 2025-08-25 21:46:25.977882 | localhost | Output suppressed because no_log was given 2025-08-25 21:46:25.980991 | 2025-08-25 21:46:25.981109 | LOOP [upload-logs : Compress console log and json output] 2025-08-25 21:46:26.055737 | localhost | skipping: Conditional result was False 2025-08-25 21:46:26.064632 | localhost | skipping: Conditional result was False 2025-08-25 21:46:26.074102 | 2025-08-25 21:46:26.074241 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-25 21:46:26.126508 | localhost | skipping: Conditional result was False 2025-08-25 21:46:26.126803 | 2025-08-25 21:46:26.131606 | localhost | skipping: Conditional result was False 2025-08-25 21:46:26.145324 | 2025-08-25 21:46:26.145452 | LOOP [upload-logs : Upload console log and json output]