2026-01-07 18:31:49.275061 | Job console starting 2026-01-07 18:31:49.287674 | Updating git repos 2026-01-07 18:31:49.327043 | Cloning repos into workspace 2026-01-07 18:31:49.363225 | Restoring repo states 2026-01-07 18:31:49.388443 | Merging changes 2026-01-07 18:31:49.980297 | Checking out repos 2026-01-07 18:31:50.144122 | Preparing playbooks 2026-01-07 18:31:51.069880 | Running Ansible setup 2026-01-07 18:31:56.754480 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-07 18:31:57.927511 | 2026-01-07 18:31:57.927684 | PLAY [Base pre] 2026-01-07 18:31:57.962152 | 2026-01-07 18:31:57.962321 | TASK [Setup log path fact] 2026-01-07 18:31:57.994654 | debian-bookworm | ok 2026-01-07 18:31:58.014887 | 2026-01-07 18:31:58.015075 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-07 18:31:58.065873 | debian-bookworm | ok 2026-01-07 18:31:58.079209 | 2026-01-07 18:31:58.079354 | TASK [emit-job-header : Print job information] 2026-01-07 18:31:58.129461 | # Job Information 2026-01-07 18:31:58.129661 | Ansible Version: 2.16.14 2026-01-07 18:31:58.129696 | Job: python-black 2026-01-07 18:31:58.129728 | Pipeline: check 2026-01-07 18:31:58.129751 | Executor: 521e9411259a 2026-01-07 18:31:58.129772 | Triggered by: https://github.com/osism/python-osism/pull/1925 2026-01-07 18:31:58.129794 | Event ID: 9e7c16e0-ebf6-11f0-80f2-0e74f2d1e5f3 2026-01-07 18:31:58.135147 | 2026-01-07 18:31:58.135283 | LOOP [emit-job-header : Print node information] 2026-01-07 18:31:58.293602 | debian-bookworm | ok: 2026-01-07 18:31:58.293805 | debian-bookworm | # Node Information 2026-01-07 18:31:58.293838 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-07 18:31:58.293863 | debian-bookworm | Hostname: debian 2026-01-07 18:31:58.293885 | debian-bookworm | Username: zuul 2026-01-07 18:31:58.293906 | debian-bookworm | Distro: Debian 12.12 2026-01-07 18:31:58.293931 | debian-bookworm | Provider: regiocloud-a 2026-01-07 18:31:58.293953 | debian-bookworm | Region: 2026-01-07 18:31:58.293974 | debian-bookworm | Label: debian-bookworm 2026-01-07 18:31:58.293994 | debian-bookworm | Product Name: OpenStack Nova 2026-01-07 18:31:58.294033 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe21:a8cb 2026-01-07 18:31:58.314436 | 2026-01-07 18:31:58.314645 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-07 18:31:59.324610 | debian-bookworm -> localhost | changed 2026-01-07 18:31:59.332997 | 2026-01-07 18:31:59.333181 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-07 18:32:01.021645 | debian-bookworm -> localhost | changed 2026-01-07 18:32:01.038724 | 2026-01-07 18:32:01.041103 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-07 18:32:01.729169 | debian-bookworm -> localhost | ok 2026-01-07 18:32:01.736092 | 2026-01-07 18:32:01.736239 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-07 18:32:01.783639 | debian-bookworm | ok 2026-01-07 18:32:01.827690 | debian-bookworm | included: /var/lib/zuul/builds/10e9bfad6542404182598aee9f0bc004/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-07 18:32:01.843200 | 2026-01-07 18:32:01.843358 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-07 18:32:03.623337 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-07 18:32:03.623583 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/10e9bfad6542404182598aee9f0bc004/work/10e9bfad6542404182598aee9f0bc004_id_rsa 2026-01-07 18:32:03.623622 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/10e9bfad6542404182598aee9f0bc004/work/10e9bfad6542404182598aee9f0bc004_id_rsa.pub 2026-01-07 18:32:03.623649 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-07 18:32:03.623674 | debian-bookworm -> localhost | SHA256:uR3Xp3+CJSCDF+G9MGwfTMPy13RtQjtulFOgmJs83gA zuul-build-sshkey 2026-01-07 18:32:03.623697 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-07 18:32:03.623731 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-07 18:32:03.623753 | debian-bookworm -> localhost | | .oo .o.o| 2026-01-07 18:32:03.623776 | debian-bookworm -> localhost | | oo+.+ .o++| 2026-01-07 18:32:03.623795 | debian-bookworm -> localhost | | .E+* .o*+ | 2026-01-07 18:32:03.623815 | debian-bookworm -> localhost | | ..+Bo=.+.o | 2026-01-07 18:32:03.623880 | debian-bookworm -> localhost | | .SoXo. + .| 2026-01-07 18:32:03.623912 | debian-bookworm -> localhost | | + *...o | 2026-01-07 18:32:03.623933 | debian-bookworm -> localhost | | . o .+. | 2026-01-07 18:32:03.623953 | debian-bookworm -> localhost | | . ...| 2026-01-07 18:32:03.623975 | debian-bookworm -> localhost | | .o| 2026-01-07 18:32:03.623996 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-07 18:32:03.624078 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.937892 2026-01-07 18:32:03.634970 | 2026-01-07 18:32:03.635142 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-07 18:32:03.689502 | debian-bookworm | ok 2026-01-07 18:32:03.717278 | debian-bookworm | included: /var/lib/zuul/builds/10e9bfad6542404182598aee9f0bc004/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-07 18:32:03.738164 | 2026-01-07 18:32:03.738355 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-07 18:32:03.804752 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:32:03.818089 | 2026-01-07 18:32:03.818261 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-07 18:32:04.923198 | debian-bookworm | changed 2026-01-07 18:32:04.934952 | 2026-01-07 18:32:04.935128 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-07 18:32:05.298605 | debian-bookworm | ok 2026-01-07 18:32:05.306234 | 2026-01-07 18:32:05.306372 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-07 18:32:06.133219 | debian-bookworm | changed 2026-01-07 18:32:06.147677 | 2026-01-07 18:32:06.147823 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-07 18:32:06.920018 | debian-bookworm | changed 2026-01-07 18:32:06.931078 | 2026-01-07 18:32:06.932050 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-07 18:32:06.983169 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:32:06.993333 | 2026-01-07 18:32:06.993467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-07 18:32:08.483320 | debian-bookworm -> localhost | changed 2026-01-07 18:32:08.498450 | 2026-01-07 18:32:08.498590 | TASK [add-build-sshkey : Add back temp key] 2026-01-07 18:32:09.040577 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/10e9bfad6542404182598aee9f0bc004/work/10e9bfad6542404182598aee9f0bc004_id_rsa (zuul-build-sshkey) 2026-01-07 18:32:09.040860 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011793 2026-01-07 18:32:09.050125 | 2026-01-07 18:32:09.050256 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-07 18:32:09.526752 | debian-bookworm | ok 2026-01-07 18:32:09.535998 | 2026-01-07 18:32:09.536185 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-07 18:32:09.562066 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:32:09.574178 | 2026-01-07 18:32:09.574319 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-07 18:32:10.201328 | debian-bookworm | ok 2026-01-07 18:32:10.227410 | 2026-01-07 18:32:10.227554 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-07 18:32:10.261525 | debian-bookworm | ok 2026-01-07 18:32:10.281444 | 2026-01-07 18:32:10.281590 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-07 18:32:10.959654 | debian-bookworm -> localhost | ok 2026-01-07 18:32:10.968186 | 2026-01-07 18:32:10.968348 | TASK [validate-host : Collect information about the host] 2026-01-07 18:32:12.456202 | debian-bookworm | ok 2026-01-07 18:32:12.467215 | 2026-01-07 18:32:12.467368 | TASK [validate-host : Sanitize hostname] 2026-01-07 18:32:12.599616 | debian-bookworm | ok 2026-01-07 18:32:12.650499 | 2026-01-07 18:32:12.650659 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-07 18:32:13.409634 | debian-bookworm -> localhost | changed 2026-01-07 18:32:13.416213 | 2026-01-07 18:32:13.416351 | TASK [validate-host : Collect information about zuul worker] 2026-01-07 18:32:13.885180 | debian-bookworm | ok 2026-01-07 18:32:13.890287 | 2026-01-07 18:32:13.893282 | TASK [validate-host : Write out all zuul information for each host] 2026-01-07 18:32:14.825415 | debian-bookworm -> localhost | changed 2026-01-07 18:32:14.840701 | 2026-01-07 18:32:14.840846 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-07 18:32:15.183546 | debian-bookworm | ok 2026-01-07 18:32:15.192198 | 2026-01-07 18:32:15.192337 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-07 18:32:16.772837 | debian-bookworm | changed: 2026-01-07 18:32:16.773239 | debian-bookworm | cd+++++++++ src/ 2026-01-07 18:32:16.773367 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-07 18:32:16.773394 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-07 18:32:16.773417 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-07 18:32:16.773438 | debian-bookworm | Containerfile 2026-01-07 18:32:16.773570 | debian-bookworm | Containerfile 2026-01-07 18:32:16.790671 | debian-bookworm | localhost | ok: Runtime: 0:00:00.033424 2026-01-07 18:32:50.958892 | 2026-01-07 18:32:50.959081 | TASK [upload-logs : Upload logs to log server] 2026-01-07 18:32:52.569832 | localhost | Output suppressed because no_log was given 2026-01-07 18:32:52.571872 | 2026-01-07 18:32:52.571984 | LOOP [upload-logs : Compress console log and json output] 2026-01-07 18:32:52.728107 | localhost | skipping: Conditional result was False 2026-01-07 18:32:52.751644 | localhost | skipping: Conditional result was False 2026-01-07 18:32:52.774237 | 2026-01-07 18:32:52.774532 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-07 18:32:52.892769 | localhost | skipping: Conditional result was False 2026-01-07 18:32:52.893100 | 2026-01-07 18:32:52.916349 | localhost | skipping: Conditional result was False 2026-01-07 18:32:52.927677 | 2026-01-07 18:32:52.927825 | LOOP [upload-logs : Upload console log and json output]