2025-06-28 20:39:22.765296 | Job console starting 2025-06-28 20:39:22.780181 | Updating git repos 2025-06-28 20:39:22.833337 | Cloning repos into workspace 2025-06-28 20:39:22.893636 | Restoring repo states 2025-06-28 20:39:22.901085 | Merging changes 2025-06-28 20:39:23.437933 | Checking out repos 2025-06-28 20:39:23.507371 | Preparing playbooks 2025-06-28 20:39:24.594797 | Running Ansible setup 2025-06-28 20:39:30.170127 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-28 20:39:32.147620 | 2025-06-28 20:39:32.148138 | PLAY [Base pre] 2025-06-28 20:39:32.189269 | 2025-06-28 20:39:32.189458 | TASK [Setup log path fact] 2025-06-28 20:39:32.243381 | debian-bookworm | ok 2025-06-28 20:39:32.274330 | 2025-06-28 20:39:32.274495 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-28 20:39:32.362775 | debian-bookworm | ok 2025-06-28 20:39:32.385378 | 2025-06-28 20:39:32.385529 | TASK [emit-job-header : Print job information] 2025-06-28 20:39:32.461941 | # Job Information 2025-06-28 20:39:32.462156 | Ansible Version: 2.16.14 2025-06-28 20:39:32.462509 | Job: container-image-python-osism-build 2025-06-28 20:39:32.462554 | Pipeline: check 2025-06-28 20:39:32.462616 | Executor: 521e9411259a 2025-06-28 20:39:32.462637 | Triggered by: https://github.com/osism/python-osism/pull/1521 2025-06-28 20:39:32.462661 | Event ID: f4021990-545f-11f0-8a7f-5a0eea7af438 2025-06-28 20:39:32.478440 | 2025-06-28 20:39:32.478612 | LOOP [emit-job-header : Print node information] 2025-06-28 20:39:32.736532 | debian-bookworm | ok: 2025-06-28 20:39:32.736886 | debian-bookworm | # Node Information 2025-06-28 20:39:32.736937 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-28 20:39:32.736963 | debian-bookworm | Hostname: debian 2025-06-28 20:39:32.736987 | debian-bookworm | Username: zuul 2025-06-28 20:39:32.737008 | debian-bookworm | Distro: Debian 12.11 2025-06-28 20:39:32.737141 | debian-bookworm | Provider: regiocloud-a 2025-06-28 20:39:32.737167 | debian-bookworm | Region: 2025-06-28 20:39:32.737190 | debian-bookworm | Label: debian-bookworm 2025-06-28 20:39:32.737211 | debian-bookworm | Product Name: OpenStack Nova 2025-06-28 20:39:32.737231 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaf:a7ca 2025-06-28 20:39:32.754489 | 2025-06-28 20:39:32.755263 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-28 20:39:33.913168 | debian-bookworm -> localhost | changed 2025-06-28 20:39:33.921743 | 2025-06-28 20:39:33.921890 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-28 20:39:36.458531 | debian-bookworm -> localhost | changed 2025-06-28 20:39:36.473987 | 2025-06-28 20:39:36.474144 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-28 20:39:37.037035 | debian-bookworm -> localhost | ok 2025-06-28 20:39:37.043392 | 2025-06-28 20:39:37.043495 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-28 20:39:37.091657 | debian-bookworm | ok 2025-06-28 20:39:37.131232 | debian-bookworm | included: /var/lib/zuul/builds/48ef1dbf2b304ad198c48e110814754c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-28 20:39:37.145330 | 2025-06-28 20:39:37.145749 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-28 20:39:39.019617 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-28 20:39:39.019822 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/48ef1dbf2b304ad198c48e110814754c/work/48ef1dbf2b304ad198c48e110814754c_id_rsa 2025-06-28 20:39:39.019864 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/48ef1dbf2b304ad198c48e110814754c/work/48ef1dbf2b304ad198c48e110814754c_id_rsa.pub 2025-06-28 20:39:39.019890 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-28 20:39:39.019916 | debian-bookworm -> localhost | SHA256:foSshI+xZgGrCiMfty9M3e0/t1J95Qa4GiZoTPUCclM zuul-build-sshkey 2025-06-28 20:39:39.019946 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-28 20:39:39.019969 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-28 20:39:39.019991 | debian-bookworm -> localhost | | .E | 2025-06-28 20:39:39.020012 | debian-bookworm -> localhost | | . + . | 2025-06-28 20:39:39.020032 | debian-bookworm -> localhost | | . o + . . | 2025-06-28 20:39:39.020052 | debian-bookworm -> localhost | | o ...... . . .| 2025-06-28 20:39:39.020071 | debian-bookworm -> localhost | | . ++.oSo. . +.| 2025-06-28 20:39:39.020095 | debian-bookworm -> localhost | | . .B=oo.+ . . =| 2025-06-28 20:39:39.020115 | debian-bookworm -> localhost | |= .o*.o .+.o . ..| 2025-06-28 20:39:39.020134 | debian-bookworm -> localhost | |+o =o. .o o . | 2025-06-28 20:39:39.020156 | debian-bookworm -> localhost | |. . .o. ..+.. | 2025-06-28 20:39:39.020177 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-28 20:39:39.020229 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.809802 2025-06-28 20:39:39.026211 | 2025-06-28 20:39:39.026293 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-28 20:39:39.064098 | debian-bookworm | ok 2025-06-28 20:39:39.073047 | debian-bookworm | included: /var/lib/zuul/builds/48ef1dbf2b304ad198c48e110814754c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-28 20:39:39.093803 | 2025-06-28 20:39:39.093891 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-28 20:39:39.106735 | debian-bookworm | skipping: Conditional result was False 2025-06-28 20:39:39.111275 | 2025-06-28 20:39:39.111347 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-28 20:39:39.733518 | debian-bookworm | changed 2025-06-28 20:39:39.738687 | 2025-06-28 20:39:39.738781 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-28 20:39:40.002712 | debian-bookworm | ok 2025-06-28 20:39:40.016191 | 2025-06-28 20:39:40.016307 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-28 20:39:40.651862 | debian-bookworm | changed 2025-06-28 20:39:40.658526 | 2025-06-28 20:39:40.658637 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-28 20:39:41.264452 | debian-bookworm | changed 2025-06-28 20:39:41.271517 | 2025-06-28 20:39:41.271629 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-28 20:39:41.285112 | debian-bookworm | skipping: Conditional result was False 2025-06-28 20:39:41.291848 | 2025-06-28 20:39:41.291954 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-28 20:39:41.740011 | debian-bookworm -> localhost | changed 2025-06-28 20:39:41.750228 | 2025-06-28 20:39:41.750325 | TASK [add-build-sshkey : Add back temp key] 2025-06-28 20:39:42.089485 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/48ef1dbf2b304ad198c48e110814754c/work/48ef1dbf2b304ad198c48e110814754c_id_rsa (zuul-build-sshkey) 2025-06-28 20:39:42.090431 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013057 2025-06-28 20:39:42.110523 | 2025-06-28 20:39:42.110774 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-28 20:39:42.496093 | debian-bookworm | ok 2025-06-28 20:39:42.501816 | 2025-06-28 20:39:42.501910 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-28 20:39:42.524789 | debian-bookworm | skipping: Conditional result was False 2025-06-28 20:39:42.536141 | 2025-06-28 20:39:42.536242 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-28 20:39:43.053236 | debian-bookworm | ok 2025-06-28 20:39:43.077212 | 2025-06-28 20:39:43.077351 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-28 20:39:43.107456 | debian-bookworm | ok 2025-06-28 20:39:43.115580 | 2025-06-28 20:39:43.115711 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-28 20:39:43.523325 | debian-bookworm -> localhost | ok 2025-06-28 20:39:43.529984 | 2025-06-28 20:39:43.530104 | TASK [validate-host : Collect information about the host] 2025-06-28 20:39:44.666507 | debian-bookworm | ok 2025-06-28 20:39:44.677911 | 2025-06-28 20:39:44.678043 | TASK [validate-host : Sanitize hostname] 2025-06-28 20:39:44.788776 | debian-bookworm | ok 2025-06-28 20:39:44.833356 | 2025-06-28 20:39:44.833492 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-28 20:39:45.516334 | debian-bookworm -> localhost | changed 2025-06-28 20:39:45.522352 | 2025-06-28 20:39:45.522473 | TASK [validate-host : Collect information about zuul worker] 2025-06-28 20:39:46.007387 | debian-bookworm | ok 2025-06-28 20:39:46.012875 | 2025-06-28 20:39:46.012999 | TASK [validate-host : Write out all zuul information for each host] 2025-06-28 20:39:46.966461 | debian-bookworm -> localhost | changed 2025-06-28 20:39:46.985539 | 2025-06-28 20:39:46.994898 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-28 20:39:47.256191 | debian-bookworm | ok 2025-06-28 20:39:47.262060 | 2025-06-28 20:39:47.262185 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-28 20:39:48.578407 | debian-bookworm | changed: 2025-06-28 20:39:48.578702 | debian-bookworm | cd+++++++++ src/ 2025-06-28 20:39:48.578749 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-28 20:39:48.578775 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-28 20:39:48.578798 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-28 20:39:48.578819 | debian-bookworm | Containerfile 2025-06-28 20:39:48.579134 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006161 2025-06-28 20:44:10.118280 | 2025-06-28 20:44:10.118394 | TASK [upload-logs : Upload logs to log server] 2025-06-28 20:44:10.686647 | localhost | Output suppressed because no_log was given 2025-06-28 20:44:10.690825 | 2025-06-28 20:44:10.691094 | LOOP [upload-logs : Compress console log and json output] 2025-06-28 20:44:10.753092 | localhost | skipping: Conditional result was False 2025-06-28 20:44:10.759617 | localhost | skipping: Conditional result was False 2025-06-28 20:44:10.773326 | 2025-06-28 20:44:10.773567 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-28 20:44:10.831163 | localhost | skipping: Conditional result was False 2025-06-28 20:44:10.831962 | 2025-06-28 20:44:10.834973 | localhost | skipping: Conditional result was False 2025-06-28 20:44:10.849278 | 2025-06-28 20:44:10.849522 | LOOP [upload-logs : Upload console log and json output]