2025-12-19 21:54:11.425531 | Job console starting 2025-12-19 21:54:11.449936 | Updating git repos 2025-12-19 21:54:11.503857 | Cloning repos into workspace 2025-12-19 21:54:11.583774 | Restoring repo states 2025-12-19 21:54:11.594447 | Merging changes 2025-12-19 21:54:12.251742 | Checking out repos 2025-12-19 21:54:12.330034 | Preparing playbooks 2025-12-19 21:54:13.141522 | Running Ansible setup 2025-12-19 21:54:19.298281 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-19 21:54:20.219708 | 2025-12-19 21:54:20.219879 | PLAY [Base pre] 2025-12-19 21:54:20.243592 | 2025-12-19 21:54:20.243780 | TASK [Setup log path fact] 2025-12-19 21:54:20.274325 | debian-bookworm | ok 2025-12-19 21:54:20.294318 | 2025-12-19 21:54:20.294521 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-19 21:54:20.366295 | debian-bookworm | ok 2025-12-19 21:54:20.387230 | 2025-12-19 21:54:20.387403 | TASK [emit-job-header : Print job information] 2025-12-19 21:54:20.459022 | # Job Information 2025-12-19 21:54:20.459227 | Ansible Version: 2.16.14 2025-12-19 21:54:20.459262 | Job: python-black 2025-12-19 21:54:20.459294 | Pipeline: check 2025-12-19 21:54:20.459316 | Executor: 521e9411259a 2025-12-19 21:54:20.459336 | Triggered by: https://github.com/osism/testbed/pull/2817 2025-12-19 21:54:20.459383 | Event ID: 3b4a2a10-dd25-11f0-8ad0-4d9b2a3255ed 2025-12-19 21:54:20.464606 | 2025-12-19 21:54:20.464744 | LOOP [emit-job-header : Print node information] 2025-12-19 21:54:20.599713 | debian-bookworm | ok: 2025-12-19 21:54:20.599929 | debian-bookworm | # Node Information 2025-12-19 21:54:20.599964 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-19 21:54:20.599990 | debian-bookworm | Hostname: debian 2025-12-19 21:54:20.600012 | debian-bookworm | Username: zuul 2025-12-19 21:54:20.600032 | debian-bookworm | Distro: Debian 12.12 2025-12-19 21:54:20.600056 | debian-bookworm | Provider: regiocloud-a 2025-12-19 21:54:20.600076 | debian-bookworm | Region: 2025-12-19 21:54:20.600098 | debian-bookworm | Label: debian-bookworm 2025-12-19 21:54:20.600118 | debian-bookworm | Product Name: OpenStack Nova 2025-12-19 21:54:20.600137 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe92:3f2f 2025-12-19 21:54:20.616202 | 2025-12-19 21:54:20.616350 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-19 21:54:21.264437 | debian-bookworm -> localhost | changed 2025-12-19 21:54:21.272166 | 2025-12-19 21:54:21.272309 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-19 21:54:22.716067 | debian-bookworm -> localhost | changed 2025-12-19 21:54:22.727623 | 2025-12-19 21:54:22.727768 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-19 21:54:23.219046 | debian-bookworm -> localhost | ok 2025-12-19 21:54:23.229465 | 2025-12-19 21:54:23.229641 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-19 21:54:23.259520 | debian-bookworm | ok 2025-12-19 21:54:23.277887 | debian-bookworm | included: /var/lib/zuul/builds/9ff21352952a456186e30a027438216b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-19 21:54:23.284618 | 2025-12-19 21:54:23.284732 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-19 21:54:24.963077 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-19 21:54:24.963614 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9ff21352952a456186e30a027438216b/work/9ff21352952a456186e30a027438216b_id_rsa 2025-12-19 21:54:24.963715 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9ff21352952a456186e30a027438216b/work/9ff21352952a456186e30a027438216b_id_rsa.pub 2025-12-19 21:54:24.963780 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-19 21:54:24.963837 | debian-bookworm -> localhost | SHA256:uInTVjAK0Xh1rjL4zmSyZeyqRhjCiy05X9gFrP4dD/M zuul-build-sshkey 2025-12-19 21:54:24.963890 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-19 21:54:24.963958 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-19 21:54:24.964010 | debian-bookworm -> localhost | | .+ .. . | 2025-12-19 21:54:24.964061 | debian-bookworm -> localhost | | ..= o | 2025-12-19 21:54:24.964109 | debian-bookworm -> localhost | |. .o .o . | 2025-12-19 21:54:24.964155 | debian-bookworm -> localhost | |o..o ..= | 2025-12-19 21:54:24.964202 | debian-bookworm -> localhost | |+=oo+.o S | 2025-12-19 21:54:24.964255 | debian-bookworm -> localhost | |*o+oo=++ | 2025-12-19 21:54:24.964302 | debian-bookworm -> localhost | |.+.oX.=* | 2025-12-19 21:54:24.964347 | debian-bookworm -> localhost | | ..@.o. E | 2025-12-19 21:54:24.964425 | debian-bookworm -> localhost | |o.o.+ | 2025-12-19 21:54:24.964476 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-19 21:54:24.964593 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.178732 2025-12-19 21:54:24.977751 | 2025-12-19 21:54:24.977917 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-19 21:54:25.013651 | debian-bookworm | ok 2025-12-19 21:54:25.027758 | debian-bookworm | included: /var/lib/zuul/builds/9ff21352952a456186e30a027438216b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-19 21:54:25.037572 | 2025-12-19 21:54:25.037686 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-19 21:54:25.072601 | debian-bookworm | skipping: Conditional result was False 2025-12-19 21:54:25.079429 | 2025-12-19 21:54:25.079551 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-19 21:54:25.734478 | debian-bookworm | changed 2025-12-19 21:54:25.744541 | 2025-12-19 21:54:25.744664 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-19 21:54:25.999446 | debian-bookworm | ok 2025-12-19 21:54:26.005493 | 2025-12-19 21:54:26.005631 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-19 21:54:26.672860 | debian-bookworm | changed 2025-12-19 21:54:26.700968 | 2025-12-19 21:54:26.701139 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-19 21:54:27.405485 | debian-bookworm | changed 2025-12-19 21:54:27.412111 | 2025-12-19 21:54:27.412245 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-19 21:54:27.453417 | debian-bookworm | skipping: Conditional result was False 2025-12-19 21:54:27.468658 | 2025-12-19 21:54:27.468855 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-19 21:54:27.983922 | debian-bookworm -> localhost | changed 2025-12-19 21:54:28.003405 | 2025-12-19 21:54:28.003548 | TASK [add-build-sshkey : Add back temp key] 2025-12-19 21:54:28.392932 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9ff21352952a456186e30a027438216b/work/9ff21352952a456186e30a027438216b_id_rsa (zuul-build-sshkey) 2025-12-19 21:54:28.393207 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011387 2025-12-19 21:54:28.401904 | 2025-12-19 21:54:28.402037 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-19 21:54:28.876642 | debian-bookworm | ok 2025-12-19 21:54:28.883245 | 2025-12-19 21:54:28.883412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-19 21:54:28.908740 | debian-bookworm | skipping: Conditional result was False 2025-12-19 21:54:28.919617 | 2025-12-19 21:54:28.919752 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-19 21:54:29.444966 | debian-bookworm | ok 2025-12-19 21:54:29.458593 | 2025-12-19 21:54:29.458786 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-19 21:54:29.501603 | debian-bookworm | ok 2025-12-19 21:54:29.506902 | 2025-12-19 21:54:29.507018 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-19 21:54:29.828995 | debian-bookworm -> localhost | ok 2025-12-19 21:54:29.841910 | 2025-12-19 21:54:29.842314 | TASK [validate-host : Collect information about the host] 2025-12-19 21:54:31.008816 | debian-bookworm | ok 2025-12-19 21:54:31.019749 | 2025-12-19 21:54:31.019894 | TASK [validate-host : Sanitize hostname] 2025-12-19 21:54:31.132669 | debian-bookworm | ok 2025-12-19 21:54:31.198196 | 2025-12-19 21:54:31.198337 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-19 21:54:31.948754 | debian-bookworm -> localhost | changed 2025-12-19 21:54:31.960862 | 2025-12-19 21:54:31.961084 | TASK [validate-host : Collect information about zuul worker] 2025-12-19 21:54:32.470054 | debian-bookworm | ok 2025-12-19 21:54:32.477857 | 2025-12-19 21:54:32.478327 | TASK [validate-host : Write out all zuul information for each host] 2025-12-19 21:54:33.189218 | debian-bookworm -> localhost | changed 2025-12-19 21:54:33.203247 | 2025-12-19 21:54:33.203407 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-19 21:54:33.500596 | debian-bookworm | ok 2025-12-19 21:54:33.509824 | 2025-12-19 21:54:33.510008 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-19 21:54:34.695116 | debian-bookworm | changed: 2025-12-19 21:54:34.695338 | debian-bookworm | cd+++++++++ src/ 2025-12-19 21:54:34.695479 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-19 21:54:34.695506 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-19 21:54:34.695528 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-19 21:54:34.695548 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022798 2025-12-19 21:55:00.618536 | 2025-12-19 21:55:00.618670 | TASK [upload-logs : Upload logs to log server] 2025-12-19 21:55:01.297073 | localhost | Output suppressed because no_log was given 2025-12-19 21:55:01.299859 | 2025-12-19 21:55:01.300000 | LOOP [upload-logs : Compress console log and json output] 2025-12-19 21:55:01.367942 | localhost | skipping: Conditional result was False 2025-12-19 21:55:01.376470 | localhost | skipping: Conditional result was False 2025-12-19 21:55:01.388791 | 2025-12-19 21:55:01.388926 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-19 21:55:01.445001 | localhost | skipping: Conditional result was False 2025-12-19 21:55:01.445331 | 2025-12-19 21:55:01.450425 | localhost | skipping: Conditional result was False 2025-12-19 21:55:01.455119 | 2025-12-19 21:55:01.455242 | LOOP [upload-logs : Upload console log and json output]