2025-06-25 08:03:06.176372 | Job console starting 2025-06-25 08:03:06.198619 | Updating git repos 2025-06-25 08:03:06.260448 | Cloning repos into workspace 2025-06-25 08:03:06.377605 | Restoring repo states 2025-06-25 08:03:06.383600 | Merging changes 2025-06-25 08:03:06.888567 | Checking out repos 2025-06-25 08:03:06.941689 | Preparing playbooks 2025-06-25 08:03:07.591094 | Running Ansible setup 2025-06-25 08:03:12.597981 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-25 08:03:13.466687 | 2025-06-25 08:03:13.466977 | PLAY [Base pre] 2025-06-25 08:03:13.485835 | 2025-06-25 08:03:13.486029 | TASK [Setup log path fact] 2025-06-25 08:03:13.528597 | debian-bookworm | ok 2025-06-25 08:03:13.573684 | 2025-06-25 08:03:13.573893 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-25 08:03:13.634601 | debian-bookworm | ok 2025-06-25 08:03:13.646041 | 2025-06-25 08:03:13.646191 | TASK [emit-job-header : Print job information] 2025-06-25 08:03:13.696202 | # Job Information 2025-06-25 08:03:13.696428 | Ansible Version: 2.16.14 2025-06-25 08:03:13.696465 | Job: python-black 2025-06-25 08:03:13.696497 | Pipeline: check 2025-06-25 08:03:13.696519 | Executor: 521e9411259a 2025-06-25 08:03:13.696540 | Triggered by: https://github.com/osism/testbed/pull/2727 2025-06-25 08:03:13.696562 | Event ID: cde5d390-519a-11f0-8ca9-b43d4f27fac7 2025-06-25 08:03:13.701780 | 2025-06-25 08:03:13.701952 | LOOP [emit-job-header : Print node information] 2025-06-25 08:03:13.868391 | debian-bookworm | ok: 2025-06-25 08:03:13.868805 | debian-bookworm | # Node Information 2025-06-25 08:03:13.868860 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-25 08:03:13.868886 | debian-bookworm | Hostname: debian 2025-06-25 08:03:13.868955 | debian-bookworm | Username: zuul 2025-06-25 08:03:13.868978 | debian-bookworm | Distro: Debian 12.11 2025-06-25 08:03:13.869002 | debian-bookworm | Provider: regiocloud-a 2025-06-25 08:03:13.869024 | debian-bookworm | Region: 2025-06-25 08:03:13.869046 | debian-bookworm | Label: debian-bookworm 2025-06-25 08:03:13.869065 | debian-bookworm | Product Name: OpenStack Nova 2025-06-25 08:03:13.869084 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feba:4881 2025-06-25 08:03:13.900487 | 2025-06-25 08:03:13.900701 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-25 08:03:14.564166 | debian-bookworm -> localhost | changed 2025-06-25 08:03:14.573186 | 2025-06-25 08:03:14.573332 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-25 08:03:15.911542 | debian-bookworm -> localhost | changed 2025-06-25 08:03:15.939374 | 2025-06-25 08:03:15.939525 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-25 08:03:16.505472 | debian-bookworm -> localhost | ok 2025-06-25 08:03:16.512294 | 2025-06-25 08:03:16.512433 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-25 08:03:16.542380 | debian-bookworm | ok 2025-06-25 08:03:16.561703 | debian-bookworm | included: /var/lib/zuul/builds/3e714391d329494e9a817a5fe31a8f8b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-25 08:03:16.568476 | 2025-06-25 08:03:16.568591 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-25 08:03:17.376950 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-25 08:03:17.377187 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3e714391d329494e9a817a5fe31a8f8b/work/3e714391d329494e9a817a5fe31a8f8b_id_rsa 2025-06-25 08:03:17.377228 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3e714391d329494e9a817a5fe31a8f8b/work/3e714391d329494e9a817a5fe31a8f8b_id_rsa.pub 2025-06-25 08:03:17.377255 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-25 08:03:17.377280 | debian-bookworm -> localhost | SHA256:FYYdU4flqu1mckndX8ZlmNMB6SyGlpAla66HXRLcYzA zuul-build-sshkey 2025-06-25 08:03:17.377302 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-25 08:03:17.377333 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-25 08:03:17.377355 | debian-bookworm -> localhost | | Eo+=o.+= | 2025-06-25 08:03:17.377376 | debian-bookworm -> localhost | | .oB..o.+ . | 2025-06-25 08:03:17.377397 | debian-bookworm -> localhost | | =.++ o .+.| 2025-06-25 08:03:17.377417 | debian-bookworm -> localhost | | o o=.o ++ +| 2025-06-25 08:03:17.377437 | debian-bookworm -> localhost | | oS.. o. =.| 2025-06-25 08:03:17.377464 | debian-bookworm -> localhost | | + o o. . =| 2025-06-25 08:03:17.377486 | debian-bookworm -> localhost | | o o .... .o| 2025-06-25 08:03:17.377506 | debian-bookworm -> localhost | | . ..= .| 2025-06-25 08:03:17.377528 | debian-bookworm -> localhost | | =. | 2025-06-25 08:03:17.377548 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-25 08:03:17.377604 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.221666 2025-06-25 08:03:17.385149 | 2025-06-25 08:03:17.385260 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-25 08:03:17.425344 | debian-bookworm | ok 2025-06-25 08:03:17.440794 | debian-bookworm | included: /var/lib/zuul/builds/3e714391d329494e9a817a5fe31a8f8b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-25 08:03:17.458996 | 2025-06-25 08:03:17.459132 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-25 08:03:17.511477 | debian-bookworm | skipping: Conditional result was False 2025-06-25 08:03:17.517769 | 2025-06-25 08:03:17.517893 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-25 08:03:18.231320 | debian-bookworm | changed 2025-06-25 08:03:18.259359 | 2025-06-25 08:03:18.259499 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-25 08:03:18.512459 | debian-bookworm | ok 2025-06-25 08:03:18.518177 | 2025-06-25 08:03:18.518293 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-25 08:03:19.156492 | debian-bookworm | changed 2025-06-25 08:03:19.166216 | 2025-06-25 08:03:19.166369 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-25 08:03:19.839505 | debian-bookworm | changed 2025-06-25 08:03:19.845380 | 2025-06-25 08:03:19.845510 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-25 08:03:19.879475 | debian-bookworm | skipping: Conditional result was False 2025-06-25 08:03:19.886148 | 2025-06-25 08:03:19.886274 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-25 08:03:20.349658 | debian-bookworm -> localhost | changed 2025-06-25 08:03:20.361262 | 2025-06-25 08:03:20.361396 | TASK [add-build-sshkey : Add back temp key] 2025-06-25 08:03:20.739131 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3e714391d329494e9a817a5fe31a8f8b/work/3e714391d329494e9a817a5fe31a8f8b_id_rsa (zuul-build-sshkey) 2025-06-25 08:03:20.739408 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020470 2025-06-25 08:03:20.747551 | 2025-06-25 08:03:20.747678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-25 08:03:21.164273 | debian-bookworm | ok 2025-06-25 08:03:21.169641 | 2025-06-25 08:03:21.169762 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-25 08:03:21.193604 | debian-bookworm | skipping: Conditional result was False 2025-06-25 08:03:21.223208 | 2025-06-25 08:03:21.223369 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-25 08:03:21.688057 | debian-bookworm | ok 2025-06-25 08:03:21.700441 | 2025-06-25 08:03:21.700585 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-25 08:03:21.735604 | debian-bookworm | ok 2025-06-25 08:03:21.743752 | 2025-06-25 08:03:21.743897 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-25 08:03:22.077547 | debian-bookworm -> localhost | ok 2025-06-25 08:03:22.085241 | 2025-06-25 08:03:22.085371 | TASK [validate-host : Collect information about the host] 2025-06-25 08:03:23.303574 | debian-bookworm | ok 2025-06-25 08:03:23.321382 | 2025-06-25 08:03:23.321514 | TASK [validate-host : Sanitize hostname] 2025-06-25 08:03:23.433280 | debian-bookworm | ok 2025-06-25 08:03:23.483085 | 2025-06-25 08:03:23.483242 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-25 08:03:24.034564 | debian-bookworm -> localhost | changed 2025-06-25 08:03:24.040480 | 2025-06-25 08:03:24.040596 | TASK [validate-host : Collect information about zuul worker] 2025-06-25 08:03:24.455808 | debian-bookworm | ok 2025-06-25 08:03:24.461069 | 2025-06-25 08:03:24.461197 | TASK [validate-host : Write out all zuul information for each host] 2025-06-25 08:03:25.207595 | debian-bookworm -> localhost | changed 2025-06-25 08:03:25.228440 | 2025-06-25 08:03:25.228578 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-25 08:03:25.545570 | debian-bookworm | ok 2025-06-25 08:03:25.555199 | 2025-06-25 08:03:25.555368 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-25 08:03:26.802396 | debian-bookworm | changed: 2025-06-25 08:03:26.802704 | debian-bookworm | cd+++++++++ src/ 2025-06-25 08:03:26.802744 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-25 08:03:26.802768 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-25 08:03:26.802790 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-25 08:03:26.802810 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005611 2025-06-25 08:03:51.907097 | 2025-06-25 08:03:51.907231 | TASK [upload-logs : Upload logs to log server] 2025-06-25 08:03:52.554525 | localhost | Output suppressed because no_log was given 2025-06-25 08:03:52.556883 | 2025-06-25 08:03:52.557587 | LOOP [upload-logs : Compress console log and json output] 2025-06-25 08:03:52.611381 | localhost | skipping: Conditional result was False 2025-06-25 08:03:52.618263 | localhost | skipping: Conditional result was False 2025-06-25 08:03:52.626709 | 2025-06-25 08:03:52.626865 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-25 08:03:52.678244 | localhost | skipping: Conditional result was False 2025-06-25 08:03:52.678524 | 2025-06-25 08:03:52.683515 | localhost | skipping: Conditional result was False 2025-06-25 08:03:52.693452 | 2025-06-25 08:03:52.693563 | LOOP [upload-logs : Upload console log and json output]