2025-10-17 13:37:40.779237 | Job console starting 2025-10-17 13:37:40.796328 | Updating git repos 2025-10-17 13:37:40.842479 | Cloning repos into workspace 2025-10-17 13:37:40.904160 | Restoring repo states 2025-10-17 13:37:40.926215 | Merging changes 2025-10-17 13:37:41.412873 | Checking out repos 2025-10-17 13:37:41.436157 | Preparing playbooks 2025-10-17 13:37:41.933226 | Running Ansible setup 2025-10-17 13:39:06.351720 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-17 13:39:06.964785 | 2025-10-17 13:39:06.964888 | PLAY [Base pre] 2025-10-17 13:39:06.976861 | 2025-10-17 13:39:06.976944 | TASK [Setup log path fact] 2025-10-17 13:39:07.003509 | debian-bookworm | ok 2025-10-17 13:39:07.015800 | 2025-10-17 13:39:07.015891 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-17 13:39:07.043221 | debian-bookworm | ok 2025-10-17 13:39:07.051736 | 2025-10-17 13:39:07.051812 | TASK [emit-job-header : Print job information] 2025-10-17 13:39:07.089229 | # Job Information 2025-10-17 13:39:07.089376 | Ansible Version: 2.16.14 2025-10-17 13:39:07.089409 | Job: container-image-python-osism-build 2025-10-17 13:39:07.089443 | Pipeline: check 2025-10-17 13:39:07.089466 | Executor: 521e9411259a 2025-10-17 13:39:07.089499 | Triggered by: https://github.com/osism/python-osism/pull/1757 2025-10-17 13:39:07.089524 | Event ID: 52b8be80-ab5e-11f0-94a4-f4a3f2a61a74 2025-10-17 13:39:07.093900 | 2025-10-17 13:39:07.093981 | LOOP [emit-job-header : Print node information] 2025-10-17 13:39:07.210591 | debian-bookworm | ok: 2025-10-17 13:39:07.210879 | debian-bookworm | # Node Information 2025-10-17 13:39:07.210954 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-17 13:39:07.211093 | debian-bookworm | Hostname: debian 2025-10-17 13:39:07.211142 | debian-bookworm | Username: zuul 2025-10-17 13:39:07.211179 | debian-bookworm | Distro: Debian 12.12 2025-10-17 13:39:07.211222 | debian-bookworm | Provider: regiocloud-a 2025-10-17 13:39:07.211258 | debian-bookworm | Region: 2025-10-17 13:39:07.211296 | debian-bookworm | Label: debian-bookworm 2025-10-17 13:39:07.211330 | debian-bookworm | Product Name: OpenStack Nova 2025-10-17 13:39:07.211362 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5a:5e91 2025-10-17 13:39:07.230810 | 2025-10-17 13:39:07.230964 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-17 13:39:07.671689 | debian-bookworm -> localhost | changed 2025-10-17 13:39:07.684746 | 2025-10-17 13:39:07.684902 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-17 13:39:08.498807 | debian-bookworm -> localhost | changed 2025-10-17 13:39:08.507857 | 2025-10-17 13:39:08.508000 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-17 13:39:08.723708 | debian-bookworm -> localhost | ok 2025-10-17 13:39:08.728654 | 2025-10-17 13:39:08.728741 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-17 13:39:08.744592 | debian-bookworm | ok 2025-10-17 13:39:08.757955 | debian-bookworm | included: /var/lib/zuul/builds/656e62d5c3b44c73886158b74ecbfe57/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-17 13:39:08.762650 | 2025-10-17 13:39:08.762717 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-17 13:39:09.715838 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-17 13:39:09.716032 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/656e62d5c3b44c73886158b74ecbfe57/work/656e62d5c3b44c73886158b74ecbfe57_id_rsa 2025-10-17 13:39:09.716071 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/656e62d5c3b44c73886158b74ecbfe57/work/656e62d5c3b44c73886158b74ecbfe57_id_rsa.pub 2025-10-17 13:39:09.716098 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-17 13:39:09.716123 | debian-bookworm -> localhost | SHA256:tElICooGPvnK38Bc7Qope/Q+aTiLdceF2CWRtUqH124 zuul-build-sshkey 2025-10-17 13:39:09.716155 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-17 13:39:09.716177 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-17 13:39:09.716198 | debian-bookworm -> localhost | |. . ..o. | 2025-10-17 13:39:09.716219 | debian-bookworm -> localhost | |+... o oo o | 2025-10-17 13:39:09.716239 | debian-bookworm -> localhost | |o= . .+o= . | 2025-10-17 13:39:09.716259 | debian-bookworm -> localhost | |. o =oBo. | 2025-10-17 13:39:09.716278 | debian-bookworm -> localhost | | . o =S. E | 2025-10-17 13:39:09.716301 | debian-bookworm -> localhost | |. +.o o . . | 2025-10-17 13:39:09.716322 | debian-bookworm -> localhost | | +.Bo..+ | 2025-10-17 13:39:09.716343 | debian-bookworm -> localhost | | *+==o | 2025-10-17 13:39:09.716364 | debian-bookworm -> localhost | | o.o=+. | 2025-10-17 13:39:09.716384 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-17 13:39:09.716431 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.510724 2025-10-17 13:39:09.723140 | 2025-10-17 13:39:09.723226 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-17 13:39:09.741988 | debian-bookworm | ok 2025-10-17 13:39:09.751195 | debian-bookworm | included: /var/lib/zuul/builds/656e62d5c3b44c73886158b74ecbfe57/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-17 13:39:09.760244 | 2025-10-17 13:39:09.760327 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-17 13:39:09.783174 | debian-bookworm | skipping: Conditional result was False 2025-10-17 13:39:09.789041 | 2025-10-17 13:39:09.789145 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-17 13:39:10.451693 | debian-bookworm | changed 2025-10-17 13:39:10.456989 | 2025-10-17 13:39:10.457072 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-17 13:39:10.716997 | debian-bookworm | ok 2025-10-17 13:39:10.722301 | 2025-10-17 13:39:10.722386 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-17 13:39:11.387652 | debian-bookworm | changed 2025-10-17 13:39:11.424445 | 2025-10-17 13:39:11.424588 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-17 13:39:12.127421 | debian-bookworm | changed 2025-10-17 13:39:12.135941 | 2025-10-17 13:39:12.136074 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-17 13:39:12.164319 | debian-bookworm | skipping: Conditional result was False 2025-10-17 13:39:12.171372 | 2025-10-17 13:39:12.171479 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-17 13:39:12.616797 | debian-bookworm -> localhost | changed 2025-10-17 13:39:12.627758 | 2025-10-17 13:39:12.627868 | TASK [add-build-sshkey : Add back temp key] 2025-10-17 13:39:12.970375 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/656e62d5c3b44c73886158b74ecbfe57/work/656e62d5c3b44c73886158b74ecbfe57_id_rsa (zuul-build-sshkey) 2025-10-17 13:39:12.971215 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018102 2025-10-17 13:39:12.986413 | 2025-10-17 13:39:12.986582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-17 13:39:13.396452 | debian-bookworm | ok 2025-10-17 13:39:13.402021 | 2025-10-17 13:39:13.402141 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-17 13:39:13.425782 | debian-bookworm | skipping: Conditional result was False 2025-10-17 13:39:13.436706 | 2025-10-17 13:39:13.436825 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-17 13:39:13.867679 | debian-bookworm | ok 2025-10-17 13:39:13.880153 | 2025-10-17 13:39:13.880272 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-17 13:39:13.922010 | debian-bookworm | ok 2025-10-17 13:39:13.928860 | 2025-10-17 13:39:13.928968 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-17 13:39:14.247316 | debian-bookworm -> localhost | ok 2025-10-17 13:39:14.254192 | 2025-10-17 13:39:14.254302 | TASK [validate-host : Collect information about the host] 2025-10-17 13:39:55.494293 | debian-bookworm | ok 2025-10-17 13:39:55.504755 | 2025-10-17 13:39:55.504872 | TASK [validate-host : Sanitize hostname] 2025-10-17 13:39:55.650933 | debian-bookworm | ok 2025-10-17 13:39:55.700917 | 2025-10-17 13:39:55.701042 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-17 13:39:56.324345 | debian-bookworm -> localhost | changed 2025-10-17 13:39:56.333615 | 2025-10-17 13:39:56.333845 | TASK [validate-host : Collect information about zuul worker] 2025-10-17 13:39:56.894728 | debian-bookworm | ok 2025-10-17 13:39:56.901285 | 2025-10-17 13:39:56.901405 | TASK [validate-host : Write out all zuul information for each host] 2025-10-17 13:39:57.724885 | debian-bookworm -> localhost | changed 2025-10-17 13:39:57.749066 | 2025-10-17 13:39:57.749213 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-17 13:39:58.031934 | debian-bookworm | ok 2025-10-17 13:39:58.041040 | 2025-10-17 13:39:58.042747 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-17 13:39:59.431045 | debian-bookworm | changed: 2025-10-17 13:39:59.431260 | debian-bookworm | cd+++++++++ src/ 2025-10-17 13:39:59.431303 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-17 13:39:59.431328 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-17 13:39:59.431351 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-17 13:39:59.431371 | debian-bookworm | Containerfile 2025-10-17 13:39:59.431518 | debian-bookworm | Containerfile 2025-10-17 13:39:59.460903 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006043 2025-10-17 13:42:17.525755 | 2025-10-17 13:42:17.525958 | TASK [upload-logs : Upload logs to log server] 2025-10-17 13:42:18.029432 | localhost | Output suppressed because no_log was given 2025-10-17 13:42:18.032008 | 2025-10-17 13:42:18.032125 | LOOP [upload-logs : Compress console log and json output] 2025-10-17 13:42:18.086751 | localhost | skipping: Conditional result was False 2025-10-17 13:42:18.091323 | localhost | skipping: Conditional result was False 2025-10-17 13:42:18.104023 | 2025-10-17 13:42:18.104263 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-17 13:42:18.145423 | localhost | skipping: Conditional result was False 2025-10-17 13:42:18.145956 | 2025-10-17 13:42:18.149192 | localhost | skipping: Conditional result was False 2025-10-17 13:42:18.160761 | 2025-10-17 13:42:18.160934 | LOOP [upload-logs : Upload console log and json output]