2025-11-20 21:30:48.857970 | Job console starting 2025-11-20 21:30:48.871336 | Updating git repos 2025-11-20 21:30:48.949247 | Cloning repos into workspace 2025-11-20 21:30:49.049775 | Restoring repo states 2025-11-20 21:30:49.099522 | Merging changes 2025-11-20 21:30:49.752473 | Checking out repos 2025-11-20 21:30:49.836402 | Preparing playbooks 2025-11-20 21:30:51.078243 | Running Ansible setup 2025-11-20 21:30:56.875663 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-20 21:30:58.261505 | 2025-11-20 21:30:58.261677 | PLAY [Base pre] 2025-11-20 21:30:58.302315 | 2025-11-20 21:30:58.302481 | TASK [Setup log path fact] 2025-11-20 21:30:58.356245 | debian-bookworm | ok 2025-11-20 21:30:58.386173 | 2025-11-20 21:30:58.386347 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 21:30:58.435741 | debian-bookworm | ok 2025-11-20 21:30:58.459283 | 2025-11-20 21:30:58.459439 | TASK [emit-job-header : Print job information] 2025-11-20 21:30:58.550572 | # Job Information 2025-11-20 21:30:58.550772 | Ansible Version: 2.16.14 2025-11-20 21:30:58.550810 | Job: python-black 2025-11-20 21:30:58.550877 | Pipeline: check 2025-11-20 21:30:58.550902 | Executor: 521e9411259a 2025-11-20 21:30:58.550924 | Triggered by: https://github.com/osism/python-osism/pull/1823 2025-11-20 21:30:58.550948 | Event ID: 291418d0-c658-11f0-893f-1bbf05a9eeaa 2025-11-20 21:30:58.564301 | 2025-11-20 21:30:58.564445 | LOOP [emit-job-header : Print node information] 2025-11-20 21:30:58.751544 | debian-bookworm | ok: 2025-11-20 21:30:58.751743 | debian-bookworm | # Node Information 2025-11-20 21:30:58.751778 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-20 21:30:58.751802 | debian-bookworm | Hostname: debian 2025-11-20 21:30:58.751825 | debian-bookworm | Username: zuul 2025-11-20 21:30:58.751845 | debian-bookworm | Distro: Debian 12.12 2025-11-20 21:30:58.751870 | debian-bookworm | Provider: regiocloud-a 2025-11-20 21:30:58.751890 | debian-bookworm | Region: 2025-11-20 21:30:58.751911 | debian-bookworm | Label: debian-bookworm 2025-11-20 21:30:58.751931 | debian-bookworm | Product Name: OpenStack Nova 2025-11-20 21:30:58.751951 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedb:9d8 2025-11-20 21:30:58.763433 | 2025-11-20 21:30:58.763573 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-20 21:30:59.723283 | debian-bookworm -> localhost | changed 2025-11-20 21:30:59.730824 | 2025-11-20 21:30:59.731237 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-20 21:31:01.950559 | debian-bookworm -> localhost | changed 2025-11-20 21:31:01.971745 | 2025-11-20 21:31:01.971884 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-20 21:31:02.465353 | debian-bookworm -> localhost | ok 2025-11-20 21:31:02.471987 | 2025-11-20 21:31:02.472131 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-20 21:31:02.503552 | debian-bookworm | ok 2025-11-20 21:31:02.542308 | debian-bookworm | included: /var/lib/zuul/builds/70f980dc33874c8a8e9206176c12554c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-20 21:31:02.561831 | 2025-11-20 21:31:02.561979 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-20 21:31:04.564816 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-20 21:31:04.565014 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/70f980dc33874c8a8e9206176c12554c/work/70f980dc33874c8a8e9206176c12554c_id_rsa 2025-11-20 21:31:04.565052 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/70f980dc33874c8a8e9206176c12554c/work/70f980dc33874c8a8e9206176c12554c_id_rsa.pub 2025-11-20 21:31:04.565091 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-20 21:31:04.565117 | debian-bookworm -> localhost | SHA256:5Ed8NUaPzVFqUjlkann2ODn1QSCLogXLTULvCiwd/Ec zuul-build-sshkey 2025-11-20 21:31:04.565139 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-20 21:31:04.565184 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-20 21:31:04.565207 | debian-bookworm -> localhost | | .+ . . +X+o| 2025-11-20 21:31:04.565228 | debian-bookworm -> localhost | | . . B .. oB+B.| 2025-11-20 21:31:04.565248 | debian-bookworm -> localhost | | o o E..o.* *o=| 2025-11-20 21:31:04.565267 | debian-bookworm -> localhost | | o o =o.. o = =o| 2025-11-20 21:31:04.565287 | debian-bookworm -> localhost | | . + o oS . = o| 2025-11-20 21:31:04.565314 | debian-bookworm -> localhost | | . . o . o | 2025-11-20 21:31:04.565335 | debian-bookworm -> localhost | | . | 2025-11-20 21:31:04.565355 | debian-bookworm -> localhost | | | 2025-11-20 21:31:04.565376 | debian-bookworm -> localhost | | | 2025-11-20 21:31:04.565396 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-20 21:31:04.565448 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.380407 2025-11-20 21:31:04.571593 | 2025-11-20 21:31:04.571695 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-20 21:31:04.597873 | debian-bookworm | ok 2025-11-20 21:31:04.612002 | debian-bookworm | included: /var/lib/zuul/builds/70f980dc33874c8a8e9206176c12554c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-20 21:31:04.619451 | 2025-11-20 21:31:04.619535 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-20 21:31:04.642035 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:31:04.646905 | 2025-11-20 21:31:04.646992 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-20 21:31:05.300424 | debian-bookworm | changed 2025-11-20 21:31:05.305733 | 2025-11-20 21:31:05.306686 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-20 21:31:05.550116 | debian-bookworm | ok 2025-11-20 21:31:05.555387 | 2025-11-20 21:31:05.555481 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-20 21:31:06.142384 | debian-bookworm | changed 2025-11-20 21:31:06.149172 | 2025-11-20 21:31:06.149267 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-20 21:31:06.757503 | debian-bookworm | changed 2025-11-20 21:31:06.765774 | 2025-11-20 21:31:06.765876 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-20 21:31:06.794103 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:31:06.802498 | 2025-11-20 21:31:06.802612 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-20 21:31:07.541316 | debian-bookworm -> localhost | changed 2025-11-20 21:31:07.552693 | 2025-11-20 21:31:07.552823 | TASK [add-build-sshkey : Add back temp key] 2025-11-20 21:31:08.156335 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/70f980dc33874c8a8e9206176c12554c/work/70f980dc33874c8a8e9206176c12554c_id_rsa (zuul-build-sshkey) 2025-11-20 21:31:08.156593 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011702 2025-11-20 21:31:08.165103 | 2025-11-20 21:31:08.165241 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-20 21:31:08.677255 | debian-bookworm | ok 2025-11-20 21:31:08.688040 | 2025-11-20 21:31:08.688224 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-20 21:31:08.729833 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:31:08.742590 | 2025-11-20 21:31:08.742725 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-20 21:31:09.265772 | debian-bookworm | ok 2025-11-20 21:31:09.279763 | 2025-11-20 21:31:09.279912 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-20 21:31:09.309022 | debian-bookworm | ok 2025-11-20 21:31:09.314358 | 2025-11-20 21:31:09.314477 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-20 21:31:09.850916 | debian-bookworm -> localhost | ok 2025-11-20 21:31:09.861296 | 2025-11-20 21:31:09.861531 | TASK [validate-host : Collect information about the host] 2025-11-20 21:31:11.410180 | debian-bookworm | ok 2025-11-20 21:31:11.420446 | 2025-11-20 21:31:11.420577 | TASK [validate-host : Sanitize hostname] 2025-11-20 21:31:11.622734 | debian-bookworm | ok 2025-11-20 21:31:11.716930 | 2025-11-20 21:31:11.717116 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-20 21:31:12.591229 | debian-bookworm -> localhost | changed 2025-11-20 21:31:12.597465 | 2025-11-20 21:31:12.597593 | TASK [validate-host : Collect information about zuul worker] 2025-11-20 21:31:13.072984 | debian-bookworm | ok 2025-11-20 21:31:13.086466 | 2025-11-20 21:31:13.086618 | TASK [validate-host : Write out all zuul information for each host] 2025-11-20 21:31:13.901190 | debian-bookworm -> localhost | changed 2025-11-20 21:31:13.910970 | 2025-11-20 21:31:13.911125 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-20 21:31:14.229701 | debian-bookworm | ok 2025-11-20 21:31:14.243626 | 2025-11-20 21:31:14.243779 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-20 21:31:15.679024 | debian-bookworm | changed: 2025-11-20 21:31:15.679281 | debian-bookworm | cd+++++++++ src/ 2025-11-20 21:31:15.679325 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-20 21:31:15.679352 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-20 21:31:15.679375 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-20 21:31:15.679396 | debian-bookworm | Containerfile 2025-11-20 21:31:15.679514 | debian-bookworm | Containerfile 2025-11-20 21:31:15.692500 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007074 2025-11-20 21:31:44.307214 | 2025-11-20 21:31:44.307338 | TASK [upload-logs : Upload logs to log server] 2025-11-20 21:31:44.907923 | localhost | Output suppressed because no_log was given 2025-11-20 21:31:44.912392 | 2025-11-20 21:31:44.912610 | LOOP [upload-logs : Compress console log and json output] 2025-11-20 21:31:44.987228 | localhost | skipping: Conditional result was False 2025-11-20 21:31:45.003932 | localhost | skipping: Conditional result was False 2025-11-20 21:31:45.015812 | 2025-11-20 21:31:45.016061 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-20 21:31:45.076367 | localhost | skipping: Conditional result was False 2025-11-20 21:31:45.076981 | 2025-11-20 21:31:45.081229 | localhost | skipping: Conditional result was False 2025-11-20 21:31:45.089487 | 2025-11-20 21:31:45.089739 | LOOP [upload-logs : Upload console log and json output]