2025-12-15 07:20:03.443338 | Job console starting 2025-12-15 07:20:03.464187 | Updating git repos 2025-12-15 07:20:03.539300 | Cloning repos into workspace 2025-12-15 07:20:03.751476 | Restoring repo states 2025-12-15 07:20:03.809969 | Merging changes 2025-12-15 07:20:04.713995 | Checking out repos 2025-12-15 07:20:04.830261 | Preparing playbooks 2025-12-15 07:20:06.163774 | Running Ansible setup 2025-12-15 07:20:13.132112 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-15 07:20:15.586447 | 2025-12-15 07:20:15.586623 | PLAY [Base pre] 2025-12-15 07:20:15.633482 | 2025-12-15 07:20:15.633655 | TASK [Setup log path fact] 2025-12-15 07:20:15.683957 | debian-bookworm | ok 2025-12-15 07:20:15.716773 | 2025-12-15 07:20:15.717409 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-15 07:20:15.768056 | debian-bookworm | ok 2025-12-15 07:20:15.785596 | 2025-12-15 07:20:15.785764 | TASK [emit-job-header : Print job information] 2025-12-15 07:20:15.866562 | # Job Information 2025-12-15 07:20:15.866829 | Ansible Version: 2.16.14 2025-12-15 07:20:15.866951 | Job: python-black 2025-12-15 07:20:15.867000 | Pipeline: check 2025-12-15 07:20:15.867032 | Executor: 521e9411259a 2025-12-15 07:20:15.867053 | Triggered by: https://github.com/osism/python-osism/pull/1910 2025-12-15 07:20:15.867076 | Event ID: 72d9b240-d986-11f0-8879-0069d75d39ec 2025-12-15 07:20:15.874747 | 2025-12-15 07:20:15.874952 | LOOP [emit-job-header : Print node information] 2025-12-15 07:20:16.253359 | debian-bookworm | ok: 2025-12-15 07:20:16.253630 | debian-bookworm | # Node Information 2025-12-15 07:20:16.253668 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-15 07:20:16.253699 | debian-bookworm | Hostname: debian 2025-12-15 07:20:16.253732 | debian-bookworm | Username: zuul 2025-12-15 07:20:16.253757 | debian-bookworm | Distro: Debian 12.12 2025-12-15 07:20:16.253780 | debian-bookworm | Provider: regiocloud-a 2025-12-15 07:20:16.253802 | debian-bookworm | Region: 2025-12-15 07:20:16.253824 | debian-bookworm | Label: debian-bookworm 2025-12-15 07:20:16.253844 | debian-bookworm | Product Name: OpenStack Nova 2025-12-15 07:20:16.253864 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedf:9ba2 2025-12-15 07:20:16.276908 | 2025-12-15 07:20:16.291032 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-15 07:20:17.779446 | debian-bookworm -> localhost | changed 2025-12-15 07:20:17.789338 | 2025-12-15 07:20:17.789489 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-15 07:20:20.833155 | debian-bookworm -> localhost | changed 2025-12-15 07:20:20.861359 | 2025-12-15 07:20:20.861905 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-15 07:20:21.781715 | debian-bookworm -> localhost | ok 2025-12-15 07:20:21.788612 | 2025-12-15 07:20:21.788753 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-15 07:20:21.838497 | debian-bookworm | ok 2025-12-15 07:20:21.877850 | debian-bookworm | included: /var/lib/zuul/builds/a7bcb1a3840d44d1ba3194d8a21b6bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-15 07:20:21.907718 | 2025-12-15 07:20:21.907863 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-15 07:20:27.498198 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-15 07:20:27.498472 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a7bcb1a3840d44d1ba3194d8a21b6bd9/work/a7bcb1a3840d44d1ba3194d8a21b6bd9_id_rsa 2025-12-15 07:20:27.498514 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a7bcb1a3840d44d1ba3194d8a21b6bd9/work/a7bcb1a3840d44d1ba3194d8a21b6bd9_id_rsa.pub 2025-12-15 07:20:27.498540 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-15 07:20:27.498566 | debian-bookworm -> localhost | SHA256:DBh23XwCQvAN/Xb7PdC03U/Psx2pruhTlHtYe2VBWQM zuul-build-sshkey 2025-12-15 07:20:27.498587 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-15 07:20:27.498621 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-15 07:20:27.498642 | debian-bookworm -> localhost | | +o=o.+ Eoo+| 2025-12-15 07:20:27.498663 | debian-bookworm -> localhost | | . = +o + . o.| 2025-12-15 07:20:27.498683 | debian-bookworm -> localhost | | . o .. o. .| 2025-12-15 07:20:27.498702 | debian-bookworm -> localhost | | o oo.. .o| 2025-12-15 07:20:27.498721 | debian-bookworm -> localhost | | S...+.+.=| 2025-12-15 07:20:27.498744 | debian-bookworm -> localhost | | +.+ +=| 2025-12-15 07:20:27.498764 | debian-bookworm -> localhost | | . ..o*o| 2025-12-15 07:20:27.498783 | debian-bookworm -> localhost | | .. ooB| 2025-12-15 07:20:27.498802 | debian-bookworm -> localhost | | .o..oo .=| 2025-12-15 07:20:27.498823 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-15 07:20:27.499146 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.935828 2025-12-15 07:20:27.506104 | 2025-12-15 07:20:27.506239 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-15 07:20:27.539368 | debian-bookworm | ok 2025-12-15 07:20:27.561004 | debian-bookworm | included: /var/lib/zuul/builds/a7bcb1a3840d44d1ba3194d8a21b6bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-15 07:20:27.576864 | 2025-12-15 07:20:27.577043 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-15 07:20:27.601628 | debian-bookworm | skipping: Conditional result was False 2025-12-15 07:20:27.609754 | 2025-12-15 07:20:27.609928 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-15 07:20:28.468566 | debian-bookworm | changed 2025-12-15 07:20:28.475221 | 2025-12-15 07:20:28.475352 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-15 07:20:28.773589 | debian-bookworm | ok 2025-12-15 07:20:28.792697 | 2025-12-15 07:20:28.792839 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-15 07:20:29.549946 | debian-bookworm | changed 2025-12-15 07:20:29.567665 | 2025-12-15 07:20:29.567817 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-15 07:20:30.259791 | debian-bookworm | changed 2025-12-15 07:20:30.269624 | 2025-12-15 07:20:30.269798 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-15 07:20:30.326525 | debian-bookworm | skipping: Conditional result was False 2025-12-15 07:20:30.336053 | 2025-12-15 07:20:30.336184 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-15 07:20:32.405295 | debian-bookworm -> localhost | changed 2025-12-15 07:20:32.427776 | 2025-12-15 07:20:32.427969 | TASK [add-build-sshkey : Add back temp key] 2025-12-15 07:20:34.364319 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a7bcb1a3840d44d1ba3194d8a21b6bd9/work/a7bcb1a3840d44d1ba3194d8a21b6bd9_id_rsa (zuul-build-sshkey) 2025-12-15 07:20:34.364579 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.056789 2025-12-15 07:20:34.373191 | 2025-12-15 07:20:34.373330 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-15 07:20:35.125193 | debian-bookworm | ok 2025-12-15 07:20:35.159057 | 2025-12-15 07:20:35.159232 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-15 07:20:35.251258 | debian-bookworm | skipping: Conditional result was False 2025-12-15 07:20:35.299345 | 2025-12-15 07:20:35.299493 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-15 07:20:36.028918 | debian-bookworm | ok 2025-12-15 07:20:36.051565 | 2025-12-15 07:20:36.051719 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-15 07:20:36.148326 | debian-bookworm | ok 2025-12-15 07:20:36.153676 | 2025-12-15 07:20:36.153802 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-15 07:20:36.956512 | debian-bookworm -> localhost | ok 2025-12-15 07:20:36.966080 | 2025-12-15 07:20:36.966216 | TASK [validate-host : Collect information about the host] 2025-12-15 07:20:38.562593 | debian-bookworm | ok 2025-12-15 07:20:38.590510 | 2025-12-15 07:20:38.590660 | TASK [validate-host : Sanitize hostname] 2025-12-15 07:20:38.751392 | debian-bookworm | ok 2025-12-15 07:20:38.807339 | 2025-12-15 07:20:38.807490 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-15 07:20:40.100330 | debian-bookworm -> localhost | changed 2025-12-15 07:20:40.108178 | 2025-12-15 07:20:40.108299 | TASK [validate-host : Collect information about zuul worker] 2025-12-15 07:20:40.625445 | debian-bookworm | ok 2025-12-15 07:20:40.630393 | 2025-12-15 07:20:40.630525 | TASK [validate-host : Write out all zuul information for each host] 2025-12-15 07:20:41.934251 | debian-bookworm -> localhost | changed 2025-12-15 07:20:41.951791 | 2025-12-15 07:20:41.951988 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-15 07:20:42.229293 | debian-bookworm | ok 2025-12-15 07:20:42.245578 | 2025-12-15 07:20:42.245766 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-15 07:20:43.811141 | debian-bookworm | changed: 2025-12-15 07:20:43.811351 | debian-bookworm | cd+++++++++ src/ 2025-12-15 07:20:43.811386 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-15 07:20:43.811410 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-15 07:20:43.811430 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-15 07:20:43.811450 | debian-bookworm | Containerfile 2025-12-15 07:20:43.811580 | debian-bookworm | Containerfile 2025-12-15 07:20:43.869778 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007038 2025-12-15 07:21:12.188215 | 2025-12-15 07:21:12.188344 | TASK [upload-logs : Upload logs to log server] 2025-12-15 07:21:12.849263 | localhost | Output suppressed because no_log was given 2025-12-15 07:21:12.851422 | 2025-12-15 07:21:12.851548 | LOOP [upload-logs : Compress console log and json output] 2025-12-15 07:21:12.925988 | localhost | skipping: Conditional result was False 2025-12-15 07:21:12.933144 | localhost | skipping: Conditional result was False 2025-12-15 07:21:12.943431 | 2025-12-15 07:21:12.943661 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-15 07:21:12.997112 | localhost | skipping: Conditional result was False 2025-12-15 07:21:12.997667 | 2025-12-15 07:21:13.001442 | localhost | skipping: Conditional result was False 2025-12-15 07:21:13.008130 | 2025-12-15 07:21:13.008310 | LOOP [upload-logs : Upload console log and json output]