2025-10-01 03:16:01.989697 | Job console starting 2025-10-01 03:16:02.010822 | Updating git repos 2025-10-01 03:16:02.045612 | Cloning repos into workspace 2025-10-01 03:16:02.109856 | Restoring repo states 2025-10-01 03:16:02.122568 | Merging changes 2025-10-01 03:16:02.122610 | Checking out repos 2025-10-01 03:16:02.190978 | Preparing playbooks 2025-10-01 03:16:02.824172 | Running Ansible setup 2025-10-01 03:16:07.616387 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-01 03:16:08.688707 | 2025-10-01 03:16:08.688881 | PLAY [Base pre] 2025-10-01 03:16:08.717789 | 2025-10-01 03:16:08.717949 | TASK [Setup log path fact] 2025-10-01 03:16:08.738355 | debian-bookworm | ok 2025-10-01 03:16:08.764393 | 2025-10-01 03:16:08.764570 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-01 03:16:08.813419 | debian-bookworm | ok 2025-10-01 03:16:08.834568 | 2025-10-01 03:16:08.834762 | TASK [emit-job-header : Print job information] 2025-10-01 03:16:08.912761 | # Job Information 2025-10-01 03:16:08.912959 | Ansible Version: 2.16.14 2025-10-01 03:16:08.912995 | Job: python-black 2025-10-01 03:16:08.913026 | Pipeline: periodic-daily 2025-10-01 03:16:08.913048 | Executor: 521e9411259a 2025-10-01 03:16:08.913069 | Triggered by: https://github.com/osism/node-image 2025-10-01 03:16:08.913090 | Event ID: 1a2c7c154391446b88ddec242c8f8611 2025-10-01 03:16:08.928205 | 2025-10-01 03:16:08.929694 | LOOP [emit-job-header : Print node information] 2025-10-01 03:16:09.081178 | debian-bookworm | ok: 2025-10-01 03:16:09.081387 | debian-bookworm | # Node Information 2025-10-01 03:16:09.081424 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-01 03:16:09.081449 | debian-bookworm | Hostname: debian 2025-10-01 03:16:09.081471 | debian-bookworm | Username: zuul 2025-10-01 03:16:09.081492 | debian-bookworm | Distro: Debian 12.12 2025-10-01 03:16:09.081515 | debian-bookworm | Provider: regiocloud-a 2025-10-01 03:16:09.081536 | debian-bookworm | Region: 2025-10-01 03:16:09.081557 | debian-bookworm | Label: debian-bookworm 2025-10-01 03:16:09.081576 | debian-bookworm | Product Name: OpenStack Nova 2025-10-01 03:16:09.081594 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe33:6bed 2025-10-01 03:16:09.110292 | 2025-10-01 03:16:09.110908 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-01 03:16:09.869470 | debian-bookworm -> localhost | changed 2025-10-01 03:16:09.888125 | 2025-10-01 03:16:09.888233 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-01 03:16:11.953032 | debian-bookworm -> localhost | changed 2025-10-01 03:16:11.970593 | 2025-10-01 03:16:11.970706 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-01 03:16:12.327658 | debian-bookworm -> localhost | ok 2025-10-01 03:16:12.332497 | 2025-10-01 03:16:12.332581 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-01 03:16:12.369373 | debian-bookworm | ok 2025-10-01 03:16:12.391926 | debian-bookworm | included: /var/lib/zuul/builds/4b32bcfa6b01434eb911bbea09b4b28e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-01 03:16:12.402414 | 2025-10-01 03:16:12.402500 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-01 03:16:13.930305 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-01 03:16:13.930470 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4b32bcfa6b01434eb911bbea09b4b28e/work/4b32bcfa6b01434eb911bbea09b4b28e_id_rsa 2025-10-01 03:16:13.930501 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4b32bcfa6b01434eb911bbea09b4b28e/work/4b32bcfa6b01434eb911bbea09b4b28e_id_rsa.pub 2025-10-01 03:16:13.930522 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-01 03:16:13.930543 | debian-bookworm -> localhost | SHA256:iDpxRaBDVfyy6HbUjYXtGOLQVd9wahQ+v8Tm2YbHano zuul-build-sshkey 2025-10-01 03:16:13.930561 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-01 03:16:13.930585 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-01 03:16:13.930603 | debian-bookworm -> localhost | | ..o+o .. +.. | 2025-10-01 03:16:13.930637 | debian-bookworm -> localhost | | . . .. . + = | 2025-10-01 03:16:13.930654 | debian-bookworm -> localhost | | o ..o o * . | 2025-10-01 03:16:13.930671 | debian-bookworm -> localhost | | ..o+.+ o. + | 2025-10-01 03:16:13.930687 | debian-bookworm -> localhost | | . o+.=SB = | 2025-10-01 03:16:13.930707 | debian-bookworm -> localhost | | +. + + o + * | 2025-10-01 03:16:13.930724 | debian-bookworm -> localhost | | o. . = =| 2025-10-01 03:16:13.930740 | debian-bookworm -> localhost | | .o . E+ | 2025-10-01 03:16:13.930757 | debian-bookworm -> localhost | | . . .+. | 2025-10-01 03:16:13.930774 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-01 03:16:13.930816 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.041972 2025-10-01 03:16:13.935902 | 2025-10-01 03:16:13.935982 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-01 03:16:13.967159 | debian-bookworm | ok 2025-10-01 03:16:13.978174 | debian-bookworm | included: /var/lib/zuul/builds/4b32bcfa6b01434eb911bbea09b4b28e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-01 03:16:13.999488 | 2025-10-01 03:16:13.999587 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-01 03:16:14.031121 | debian-bookworm | skipping: Conditional result was False 2025-10-01 03:16:14.035861 | 2025-10-01 03:16:14.035948 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-01 03:16:14.659939 | debian-bookworm | changed 2025-10-01 03:16:14.666531 | 2025-10-01 03:16:14.666639 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-01 03:16:14.911628 | debian-bookworm | ok 2025-10-01 03:16:14.917600 | 2025-10-01 03:16:14.917732 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-01 03:16:15.512592 | debian-bookworm | changed 2025-10-01 03:16:15.519004 | 2025-10-01 03:16:15.519091 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-01 03:16:16.072352 | debian-bookworm | changed 2025-10-01 03:16:16.078897 | 2025-10-01 03:16:16.079001 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-01 03:16:16.091863 | debian-bookworm | skipping: Conditional result was False 2025-10-01 03:16:16.097554 | 2025-10-01 03:16:16.097665 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-01 03:16:16.569535 | debian-bookworm -> localhost | changed 2025-10-01 03:16:16.585002 | 2025-10-01 03:16:16.585107 | TASK [add-build-sshkey : Add back temp key] 2025-10-01 03:16:16.874329 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4b32bcfa6b01434eb911bbea09b4b28e/work/4b32bcfa6b01434eb911bbea09b4b28e_id_rsa (zuul-build-sshkey) 2025-10-01 03:16:16.874534 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014698 2025-10-01 03:16:16.881926 | 2025-10-01 03:16:16.882022 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-01 03:16:17.243195 | debian-bookworm | ok 2025-10-01 03:16:17.258819 | 2025-10-01 03:16:17.258936 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-01 03:16:17.281707 | debian-bookworm | skipping: Conditional result was False 2025-10-01 03:16:17.291722 | 2025-10-01 03:16:17.291816 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-01 03:16:17.713354 | debian-bookworm | ok 2025-10-01 03:16:17.733658 | 2025-10-01 03:16:17.733765 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-01 03:16:17.761129 | debian-bookworm | ok 2025-10-01 03:16:17.767120 | 2025-10-01 03:16:17.767216 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-01 03:16:18.063447 | debian-bookworm -> localhost | ok 2025-10-01 03:16:18.068428 | 2025-10-01 03:16:18.068503 | TASK [validate-host : Collect information about the host] 2025-10-01 03:16:19.070110 | debian-bookworm | ok 2025-10-01 03:16:19.090263 | 2025-10-01 03:16:19.090370 | TASK [validate-host : Sanitize hostname] 2025-10-01 03:16:19.199217 | debian-bookworm | ok 2025-10-01 03:16:19.226537 | 2025-10-01 03:16:19.226659 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-01 03:16:19.816847 | debian-bookworm -> localhost | changed 2025-10-01 03:16:19.822291 | 2025-10-01 03:16:19.822385 | TASK [validate-host : Collect information about zuul worker] 2025-10-01 03:16:20.233027 | debian-bookworm | ok 2025-10-01 03:16:20.237556 | 2025-10-01 03:16:20.237674 | TASK [validate-host : Write out all zuul information for each host] 2025-10-01 03:16:20.727789 | debian-bookworm -> localhost | changed 2025-10-01 03:16:20.736671 | 2025-10-01 03:16:20.736758 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-01 03:16:20.965295 | debian-bookworm | ok 2025-10-01 03:16:20.970371 | 2025-10-01 03:16:20.970459 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-01 03:16:22.566751 | debian-bookworm | changed: 2025-10-01 03:16:22.568591 | debian-bookworm | cd+++++++++ src/ 2025-10-01 03:16:22.569336 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-01 03:16:22.569820 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-01 03:16:22.569861 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-10-01 03:16:22.569885 | debian-bookworm | Containerfile 2025-10-01 03:16:22.570022 | debian-bookworm | localhost | ok: Runtime: 0:00:00.063232 2025-10-01 03:16:54.568149 | 2025-10-01 03:16:54.568230 | TASK [upload-logs : Upload logs to log server] 2025-10-01 03:16:55.809353 | localhost | Output suppressed because no_log was given 2025-10-01 03:16:55.810739 | 2025-10-01 03:16:55.810815 | LOOP [upload-logs : Compress console log and json output] 2025-10-01 03:16:55.895190 | localhost | skipping: Conditional result was False 2025-10-01 03:16:55.903993 | localhost | skipping: Conditional result was False 2025-10-01 03:16:55.912139 | 2025-10-01 03:16:55.912234 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-01 03:16:56.001634 | localhost | skipping: Conditional result was False 2025-10-01 03:16:56.001849 | 2025-10-01 03:16:56.012213 | localhost | skipping: Conditional result was False 2025-10-01 03:16:56.017337 | 2025-10-01 03:16:56.017429 | LOOP [upload-logs : Upload console log and json output]