2025-06-23 19:59:59.492685 | Job console starting 2025-06-23 19:59:59.525495 | Updating git repos 2025-06-23 19:59:59.593345 | Cloning repos into workspace 2025-06-23 19:59:59.664886 | Restoring repo states 2025-06-23 19:59:59.681386 | Merging changes 2025-06-23 20:00:00.273493 | Checking out repos 2025-06-23 20:00:00.375810 | Preparing playbooks 2025-06-23 20:00:01.575939 | Running Ansible setup 2025-06-23 20:00:06.524249 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-23 20:00:07.554370 | 2025-06-23 20:00:07.554511 | PLAY [Base pre] 2025-06-23 20:00:07.579509 | 2025-06-23 20:00:07.579654 | TASK [Setup log path fact] 2025-06-23 20:00:07.607724 | debian-bookworm | ok 2025-06-23 20:00:07.638087 | 2025-06-23 20:00:07.638258 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-23 20:00:07.679046 | debian-bookworm | ok 2025-06-23 20:00:07.700159 | 2025-06-23 20:00:07.700332 | TASK [emit-job-header : Print job information] 2025-06-23 20:00:07.749535 | # Job Information 2025-06-23 20:00:07.749711 | Ansible Version: 2.16.14 2025-06-23 20:00:07.749747 | Job: container-image-python-osism-build 2025-06-23 20:00:07.749781 | Pipeline: check 2025-06-23 20:00:07.749804 | Executor: 521e9411259a 2025-06-23 20:00:07.749825 | Triggered by: https://github.com/osism/python-osism/pull/1502 2025-06-23 20:00:07.749848 | Event ID: 9f4f26a0-506c-11f0-9fce-1631ba309c39 2025-06-23 20:00:07.755021 | 2025-06-23 20:00:07.755154 | LOOP [emit-job-header : Print node information] 2025-06-23 20:00:07.884130 | debian-bookworm | ok: 2025-06-23 20:00:07.884305 | debian-bookworm | # Node Information 2025-06-23 20:00:07.884342 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-23 20:00:07.884369 | debian-bookworm | Hostname: debian 2025-06-23 20:00:07.884392 | debian-bookworm | Username: zuul 2025-06-23 20:00:07.884413 | debian-bookworm | Distro: Debian 12.11 2025-06-23 20:00:07.884436 | debian-bookworm | Provider: regiocloud-a 2025-06-23 20:00:07.884458 | debian-bookworm | Region: 2025-06-23 20:00:07.884480 | debian-bookworm | Label: debian-bookworm 2025-06-23 20:00:07.884500 | debian-bookworm | Product Name: OpenStack Nova 2025-06-23 20:00:07.884520 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:c12b 2025-06-23 20:00:07.906662 | 2025-06-23 20:00:07.906779 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-23 20:00:08.689291 | debian-bookworm -> localhost | changed 2025-06-23 20:00:08.696518 | 2025-06-23 20:00:08.696623 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-23 20:00:10.159488 | debian-bookworm -> localhost | changed 2025-06-23 20:00:10.186213 | 2025-06-23 20:00:10.186449 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-23 20:00:10.719300 | debian-bookworm -> localhost | ok 2025-06-23 20:00:10.725810 | 2025-06-23 20:00:10.725947 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-23 20:00:10.775345 | debian-bookworm | ok 2025-06-23 20:00:10.806091 | debian-bookworm | included: /var/lib/zuul/builds/d6cca6ad9cb3406b9c8cbbe64c84d697/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-23 20:00:10.825042 | 2025-06-23 20:00:10.825232 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-23 20:00:13.239332 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-23 20:00:13.239581 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d6cca6ad9cb3406b9c8cbbe64c84d697/work/d6cca6ad9cb3406b9c8cbbe64c84d697_id_rsa 2025-06-23 20:00:13.239624 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d6cca6ad9cb3406b9c8cbbe64c84d697/work/d6cca6ad9cb3406b9c8cbbe64c84d697_id_rsa.pub 2025-06-23 20:00:13.239652 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-23 20:00:13.239678 | debian-bookworm -> localhost | SHA256:eru7yhOFPrU3xxlBFVrvlfHJ8F0pfU72GT5/RU4f8tw zuul-build-sshkey 2025-06-23 20:00:13.239715 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-23 20:00:13.239737 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-23 20:00:13.239759 | debian-bookworm -> localhost | | ..o=oo| 2025-06-23 20:00:13.239781 | debian-bookworm -> localhost | | .=+*&| 2025-06-23 20:00:13.239801 | debian-bookworm -> localhost | | . ..*%&| 2025-06-23 20:00:13.239821 | debian-bookworm -> localhost | | . o . BE| 2025-06-23 20:00:13.239840 | debian-bookworm -> localhost | | . oS. . o =| 2025-06-23 20:00:13.239863 | debian-bookworm -> localhost | | +.. o + o| 2025-06-23 20:00:13.239884 | debian-bookworm -> localhost | | .o.. o .| 2025-06-23 20:00:13.239903 | debian-bookworm -> localhost | | ... . | 2025-06-23 20:00:13.239925 | debian-bookworm -> localhost | | oo=+ | 2025-06-23 20:00:13.239945 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-23 20:00:13.240002 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.445485 2025-06-23 20:00:13.247950 | 2025-06-23 20:00:13.248074 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-23 20:00:13.277083 | debian-bookworm | ok 2025-06-23 20:00:13.288890 | debian-bookworm | included: /var/lib/zuul/builds/d6cca6ad9cb3406b9c8cbbe64c84d697/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-23 20:00:13.299549 | 2025-06-23 20:00:13.299680 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-23 20:00:13.325344 | debian-bookworm | skipping: Conditional result was False 2025-06-23 20:00:13.333743 | 2025-06-23 20:00:13.333988 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-23 20:00:14.048543 | debian-bookworm | changed 2025-06-23 20:00:14.056274 | 2025-06-23 20:00:14.056402 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-23 20:00:14.310942 | debian-bookworm | ok 2025-06-23 20:00:14.321563 | 2025-06-23 20:00:14.321715 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-23 20:00:14.933670 | debian-bookworm | changed 2025-06-23 20:00:14.940668 | 2025-06-23 20:00:14.940784 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-23 20:00:15.541712 | debian-bookworm | changed 2025-06-23 20:00:15.549463 | 2025-06-23 20:00:15.549613 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-23 20:00:15.588371 | debian-bookworm | skipping: Conditional result was False 2025-06-23 20:00:15.594776 | 2025-06-23 20:00:15.594972 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-23 20:00:16.131457 | debian-bookworm -> localhost | changed 2025-06-23 20:00:16.142793 | 2025-06-23 20:00:16.149265 | TASK [add-build-sshkey : Add back temp key] 2025-06-23 20:00:16.669531 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d6cca6ad9cb3406b9c8cbbe64c84d697/work/d6cca6ad9cb3406b9c8cbbe64c84d697_id_rsa (zuul-build-sshkey) 2025-06-23 20:00:16.669793 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013850 2025-06-23 20:00:16.678349 | 2025-06-23 20:00:16.678484 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-23 20:00:17.196161 | debian-bookworm | ok 2025-06-23 20:00:17.201470 | 2025-06-23 20:00:17.201606 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-23 20:00:17.226512 | debian-bookworm | skipping: Conditional result was False 2025-06-23 20:00:17.237651 | 2025-06-23 20:00:17.237811 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-23 20:00:17.704465 | debian-bookworm | ok 2025-06-23 20:00:17.716217 | 2025-06-23 20:00:17.716358 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-23 20:00:17.770331 | debian-bookworm | ok 2025-06-23 20:00:17.776175 | 2025-06-23 20:00:17.776308 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-23 20:00:18.220986 | debian-bookworm -> localhost | ok 2025-06-23 20:00:18.231356 | 2025-06-23 20:00:18.231658 | TASK [validate-host : Collect information about the host] 2025-06-23 20:00:19.443035 | debian-bookworm | ok 2025-06-23 20:00:19.464569 | 2025-06-23 20:00:19.464861 | TASK [validate-host : Sanitize hostname] 2025-06-23 20:00:19.667490 | debian-bookworm | ok 2025-06-23 20:00:19.748889 | 2025-06-23 20:00:19.749046 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-23 20:00:21.232225 | debian-bookworm -> localhost | changed 2025-06-23 20:00:21.239537 | 2025-06-23 20:00:21.239678 | TASK [validate-host : Collect information about zuul worker] 2025-06-23 20:00:21.644933 | debian-bookworm | ok 2025-06-23 20:00:21.648883 | 2025-06-23 20:00:21.648967 | TASK [validate-host : Write out all zuul information for each host] 2025-06-23 20:00:22.607150 | debian-bookworm -> localhost | changed 2025-06-23 20:00:22.633104 | 2025-06-23 20:00:22.633502 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-23 20:00:22.980987 | debian-bookworm | ok 2025-06-23 20:00:22.987846 | 2025-06-23 20:00:22.988012 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-23 20:00:24.107871 | debian-bookworm | changed: 2025-06-23 20:00:24.108169 | debian-bookworm | cd+++++++++ src/ 2025-06-23 20:00:24.108299 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-23 20:00:24.108339 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-23 20:00:24.108363 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-23 20:00:24.108385 | debian-bookworm | Containerfile 2025-06-23 20:00:24.108589 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006501 2025-06-23 20:08:07.366668 | 2025-06-23 20:08:07.366810 | TASK [upload-logs : Upload logs to log server] 2025-06-23 20:08:07.944776 | localhost | Output suppressed because no_log was given 2025-06-23 20:08:07.949148 | 2025-06-23 20:08:07.949378 | LOOP [upload-logs : Compress console log and json output] 2025-06-23 20:08:08.010621 | localhost | skipping: Conditional result was False 2025-06-23 20:08:08.017473 | localhost | skipping: Conditional result was False 2025-06-23 20:08:08.034528 | 2025-06-23 20:08:08.034807 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-23 20:08:08.085831 | localhost | skipping: Conditional result was False 2025-06-23 20:08:08.086156 | 2025-06-23 20:08:08.090741 | localhost | skipping: Conditional result was False 2025-06-23 20:08:08.099841 | 2025-06-23 20:08:08.100103 | LOOP [upload-logs : Upload console log and json output]