2025-08-09 17:34:27.591692 | Job console starting 2025-08-09 17:34:27.613656 | Updating git repos 2025-08-09 17:34:27.667741 | Cloning repos into workspace 2025-08-09 17:34:27.769255 | Restoring repo states 2025-08-09 17:34:27.779599 | Merging changes 2025-08-09 17:34:28.404524 | Checking out repos 2025-08-09 17:34:28.484022 | Preparing playbooks 2025-08-09 17:34:29.873773 | Running Ansible setup 2025-08-09 17:34:35.499994 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-09 17:34:36.631430 | 2025-08-09 17:34:36.631555 | PLAY [Base pre] 2025-08-09 17:34:36.645958 | 2025-08-09 17:34:36.646064 | TASK [Setup log path fact] 2025-08-09 17:34:36.667086 | debian-bookworm | ok 2025-08-09 17:34:36.691924 | 2025-08-09 17:34:36.692056 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-09 17:34:36.721117 | debian-bookworm | ok 2025-08-09 17:34:36.732405 | 2025-08-09 17:34:36.732504 | TASK [emit-job-header : Print job information] 2025-08-09 17:34:36.780754 | # Job Information 2025-08-09 17:34:36.780985 | Ansible Version: 2.16.14 2025-08-09 17:34:36.781024 | Job: container-image-python-osism-build 2025-08-09 17:34:36.781061 | Pipeline: check 2025-08-09 17:34:36.781089 | Executor: 521e9411259a 2025-08-09 17:34:36.781109 | Triggered by: https://github.com/osism/python-osism/pull/1629 2025-08-09 17:34:36.781132 | Event ID: 143aa1c0-7547-11f0-939d-0765c1bc44e5 2025-08-09 17:34:36.785985 | 2025-08-09 17:34:36.786084 | LOOP [emit-job-header : Print node information] 2025-08-09 17:34:36.910463 | debian-bookworm | ok: 2025-08-09 17:34:36.910608 | debian-bookworm | # Node Information 2025-08-09 17:34:36.910644 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-09 17:34:36.910669 | debian-bookworm | Hostname: debian 2025-08-09 17:34:36.910690 | debian-bookworm | Username: zuul 2025-08-09 17:34:36.910711 | debian-bookworm | Distro: Debian 12.11 2025-08-09 17:34:36.910734 | debian-bookworm | Provider: regiocloud-a 2025-08-09 17:34:36.910755 | debian-bookworm | Region: 2025-08-09 17:34:36.910776 | debian-bookworm | Label: debian-bookworm 2025-08-09 17:34:36.910796 | debian-bookworm | Product Name: OpenStack Nova 2025-08-09 17:34:36.910815 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe61:51b0 2025-08-09 17:34:36.921927 | 2025-08-09 17:34:36.922033 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-09 17:34:37.468580 | debian-bookworm -> localhost | changed 2025-08-09 17:34:37.475543 | 2025-08-09 17:34:37.475652 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-09 17:34:38.996338 | debian-bookworm -> localhost | changed 2025-08-09 17:34:39.004758 | 2025-08-09 17:34:39.004839 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-09 17:34:39.421420 | debian-bookworm -> localhost | ok 2025-08-09 17:34:39.426602 | 2025-08-09 17:34:39.426690 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-09 17:34:39.453630 | debian-bookworm | ok 2025-08-09 17:34:39.483629 | debian-bookworm | included: /var/lib/zuul/builds/f952502fef1f4bb39b06b37a678ca9b4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-09 17:34:39.494673 | 2025-08-09 17:34:39.494752 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-09 17:34:41.798475 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-09 17:34:41.798636 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f952502fef1f4bb39b06b37a678ca9b4/work/f952502fef1f4bb39b06b37a678ca9b4_id_rsa 2025-08-09 17:34:41.798667 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f952502fef1f4bb39b06b37a678ca9b4/work/f952502fef1f4bb39b06b37a678ca9b4_id_rsa.pub 2025-08-09 17:34:41.798690 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-09 17:34:41.798709 | debian-bookworm -> localhost | SHA256:jkZQ4odyWVKugxrSqj9btROj5KKWhpj2j+NfDjOYOoU zuul-build-sshkey 2025-08-09 17:34:41.798734 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-09 17:34:41.798753 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-09 17:34:41.798771 | debian-bookworm -> localhost | | o.+ | 2025-08-09 17:34:41.798789 | debian-bookworm -> localhost | | . O | 2025-08-09 17:34:41.798806 | debian-bookworm -> localhost | | . * o | 2025-08-09 17:34:41.798822 | debian-bookworm -> localhost | | . + + | 2025-08-09 17:34:41.798908 | debian-bookworm -> localhost | |o + + = S | 2025-08-09 17:34:41.798931 | debian-bookworm -> localhost | |.E +o= * | 2025-08-09 17:34:41.798949 | debian-bookworm -> localhost | |=.+o++=.. | 2025-08-09 17:34:41.798966 | debian-bookworm -> localhost | |=Bo+..*. | 2025-08-09 17:34:41.798983 | debian-bookworm -> localhost | |*o**+o . | 2025-08-09 17:34:41.799000 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-09 17:34:41.799056 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.603508 2025-08-09 17:34:41.804126 | 2025-08-09 17:34:41.804205 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-09 17:34:41.824504 | debian-bookworm | ok 2025-08-09 17:34:41.831795 | debian-bookworm | included: /var/lib/zuul/builds/f952502fef1f4bb39b06b37a678ca9b4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-09 17:34:41.839175 | 2025-08-09 17:34:41.839242 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-09 17:34:41.851653 | debian-bookworm | skipping: Conditional result was False 2025-08-09 17:34:41.856130 | 2025-08-09 17:34:41.856200 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-09 17:34:42.438478 | debian-bookworm | changed 2025-08-09 17:34:42.446947 | 2025-08-09 17:34:42.447041 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-09 17:34:42.707112 | debian-bookworm | ok 2025-08-09 17:34:42.717973 | 2025-08-09 17:34:42.718088 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-09 17:34:43.353007 | debian-bookworm | changed 2025-08-09 17:34:43.358328 | 2025-08-09 17:34:43.358405 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-09 17:34:43.975964 | debian-bookworm | changed 2025-08-09 17:34:43.981290 | 2025-08-09 17:34:43.981377 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-09 17:34:44.004228 | debian-bookworm | skipping: Conditional result was False 2025-08-09 17:34:44.010099 | 2025-08-09 17:34:44.010202 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-09 17:34:44.463133 | debian-bookworm -> localhost | changed 2025-08-09 17:34:44.473175 | 2025-08-09 17:34:44.473266 | TASK [add-build-sshkey : Add back temp key] 2025-08-09 17:34:44.910595 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f952502fef1f4bb39b06b37a678ca9b4/work/f952502fef1f4bb39b06b37a678ca9b4_id_rsa (zuul-build-sshkey) 2025-08-09 17:34:44.910782 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.031576 2025-08-09 17:34:44.917008 | 2025-08-09 17:34:44.917086 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-09 17:34:45.343340 | debian-bookworm | ok 2025-08-09 17:34:45.347408 | 2025-08-09 17:34:45.347484 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-09 17:34:45.380085 | debian-bookworm | skipping: Conditional result was False 2025-08-09 17:34:45.389686 | 2025-08-09 17:34:45.389777 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-09 17:34:45.831489 | debian-bookworm | ok 2025-08-09 17:34:45.839918 | 2025-08-09 17:34:45.840000 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-09 17:34:45.866223 | debian-bookworm | ok 2025-08-09 17:34:45.870215 | 2025-08-09 17:34:45.870289 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-09 17:34:46.148370 | debian-bookworm -> localhost | ok 2025-08-09 17:34:46.153434 | 2025-08-09 17:34:46.153519 | TASK [validate-host : Collect information about the host] 2025-08-09 17:34:47.265392 | debian-bookworm | ok 2025-08-09 17:34:47.279439 | 2025-08-09 17:34:47.279544 | TASK [validate-host : Sanitize hostname] 2025-08-09 17:34:47.422749 | debian-bookworm | ok 2025-08-09 17:34:47.472345 | 2025-08-09 17:34:47.472448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-09 17:34:48.121929 | debian-bookworm -> localhost | changed 2025-08-09 17:34:48.127223 | 2025-08-09 17:34:48.127314 | TASK [validate-host : Collect information about zuul worker] 2025-08-09 17:34:48.563063 | debian-bookworm | ok 2025-08-09 17:34:48.579195 | 2025-08-09 17:34:48.579432 | TASK [validate-host : Write out all zuul information for each host] 2025-08-09 17:34:49.246062 | debian-bookworm -> localhost | changed 2025-08-09 17:34:49.255219 | 2025-08-09 17:34:49.255326 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-09 17:34:49.524237 | debian-bookworm | ok 2025-08-09 17:34:49.529462 | 2025-08-09 17:34:49.529547 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-09 17:34:50.875873 | debian-bookworm | changed: 2025-08-09 17:34:50.876065 | debian-bookworm | cd+++++++++ src/ 2025-08-09 17:34:50.876099 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-09 17:34:50.876123 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-09 17:34:50.876144 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-09 17:34:50.876164 | debian-bookworm | Containerfile 2025-08-09 17:34:50.876275 | debian-bookworm | Containerfile 2025-08-09 17:34:50.903884 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006495 2025-08-09 17:36:09.619600 | 2025-08-09 17:36:09.619714 | TASK [upload-logs : Upload logs to log server] 2025-08-09 17:36:10.151229 | localhost | Output suppressed because no_log was given 2025-08-09 17:36:10.153193 | 2025-08-09 17:36:10.153300 | LOOP [upload-logs : Compress console log and json output] 2025-08-09 17:36:10.204321 | localhost | skipping: Conditional result was False 2025-08-09 17:36:10.209121 | localhost | skipping: Conditional result was False 2025-08-09 17:36:10.222452 | 2025-08-09 17:36:10.222637 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-09 17:36:10.269147 | localhost | skipping: Conditional result was False 2025-08-09 17:36:10.269744 | 2025-08-09 17:36:10.273157 | localhost | skipping: Conditional result was False 2025-08-09 17:36:10.285398 | 2025-08-09 17:36:10.285582 | LOOP [upload-logs : Upload console log and json output]