2025-06-16 08:31:52.343796 | Job console starting 2025-06-16 08:31:52.356361 | Updating git repos 2025-06-16 08:31:52.377760 | Cloning repos into workspace 2025-06-16 08:31:52.422140 | Restoring repo states 2025-06-16 08:31:52.444170 | Merging changes 2025-06-16 08:31:52.939604 | Checking out repos 2025-06-16 08:31:52.995353 | Preparing playbooks 2025-06-16 08:31:53.689208 | Running Ansible setup 2025-06-16 08:31:58.416135 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-16 08:31:59.339352 | 2025-06-16 08:31:59.339597 | PLAY [Base pre] 2025-06-16 08:31:59.357693 | 2025-06-16 08:31:59.357841 | TASK [Setup log path fact] 2025-06-16 08:31:59.387296 | debian-bookworm | ok 2025-06-16 08:31:59.402675 | 2025-06-16 08:31:59.402821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-16 08:31:59.451660 | debian-bookworm | ok 2025-06-16 08:31:59.466195 | 2025-06-16 08:31:59.466397 | TASK [emit-job-header : Print job information] 2025-06-16 08:31:59.532152 | # Job Information 2025-06-16 08:31:59.532477 | Ansible Version: 2.16.14 2025-06-16 08:31:59.532540 | Job: container-image-python-osism-build 2025-06-16 08:31:59.532596 | Pipeline: check 2025-06-16 08:31:59.532636 | Executor: 521e9411259a 2025-06-16 08:31:59.532673 | Triggered by: https://github.com/osism/python-osism/pull/1439 2025-06-16 08:31:59.532714 | Event ID: 3d4711b0-4a8c-11f0-9aec-8cab4e06dd16 2025-06-16 08:31:59.540562 | 2025-06-16 08:31:59.540695 | LOOP [emit-job-header : Print node information] 2025-06-16 08:31:59.655890 | debian-bookworm | ok: 2025-06-16 08:31:59.656087 | debian-bookworm | # Node Information 2025-06-16 08:31:59.656126 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-16 08:31:59.656152 | debian-bookworm | Hostname: debian 2025-06-16 08:31:59.656174 | debian-bookworm | Username: zuul 2025-06-16 08:31:59.656194 | debian-bookworm | Distro: Debian 12.11 2025-06-16 08:31:59.656218 | debian-bookworm | Provider: regiocloud-a 2025-06-16 08:31:59.656239 | debian-bookworm | Region: 2025-06-16 08:31:59.656279 | debian-bookworm | Label: debian-bookworm 2025-06-16 08:31:59.656299 | debian-bookworm | Product Name: OpenStack Nova 2025-06-16 08:31:59.656318 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe24:f090 2025-06-16 08:31:59.680854 | 2025-06-16 08:31:59.681026 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-16 08:32:00.248011 | debian-bookworm -> localhost | changed 2025-06-16 08:32:00.256975 | 2025-06-16 08:32:00.257116 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-16 08:32:01.439176 | debian-bookworm -> localhost | changed 2025-06-16 08:32:01.451394 | 2025-06-16 08:32:01.451542 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-16 08:32:01.745839 | debian-bookworm -> localhost | ok 2025-06-16 08:32:01.755553 | 2025-06-16 08:32:01.755702 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-16 08:32:01.796646 | debian-bookworm | ok 2025-06-16 08:32:01.816817 | debian-bookworm | included: /var/lib/zuul/builds/e544f3fe413c414594c128bff1a92f1a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-16 08:32:01.823383 | 2025-06-16 08:32:01.823514 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-16 08:32:03.073897 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-16 08:32:03.074179 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e544f3fe413c414594c128bff1a92f1a/work/e544f3fe413c414594c128bff1a92f1a_id_rsa 2025-06-16 08:32:03.074229 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e544f3fe413c414594c128bff1a92f1a/work/e544f3fe413c414594c128bff1a92f1a_id_rsa.pub 2025-06-16 08:32:03.074298 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-16 08:32:03.074327 | debian-bookworm -> localhost | SHA256:BX6byz867dO9kdV1IrTXgW2cDKLG6JpNXbs6D0oTsSc zuul-build-sshkey 2025-06-16 08:32:03.074367 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-16 08:32:03.074391 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-16 08:32:03.074412 | debian-bookworm -> localhost | | . ...*..| 2025-06-16 08:32:03.074433 | debian-bookworm -> localhost | | .o....o B.| 2025-06-16 08:32:03.074453 | debian-bookworm -> localhost | | o.+o.o + +| 2025-06-16 08:32:03.074471 | debian-bookworm -> localhost | | . =o.o.o .+| 2025-06-16 08:32:03.074491 | debian-bookworm -> localhost | | ESoo. o| 2025-06-16 08:32:03.074520 | debian-bookworm -> localhost | | = +. .. o| 2025-06-16 08:32:03.074540 | debian-bookworm -> localhost | | o + .oo . + | 2025-06-16 08:32:03.074561 | debian-bookworm -> localhost | | . o.+.+ . o| 2025-06-16 08:32:03.074582 | debian-bookworm -> localhost | | . .+=oo ..| 2025-06-16 08:32:03.074603 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-16 08:32:03.074656 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.744427 2025-06-16 08:32:03.085036 | 2025-06-16 08:32:03.085161 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-16 08:32:03.125172 | debian-bookworm | ok 2025-06-16 08:32:03.140703 | debian-bookworm | included: /var/lib/zuul/builds/e544f3fe413c414594c128bff1a92f1a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-16 08:32:03.157039 | 2025-06-16 08:32:03.157165 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-16 08:32:03.184640 | debian-bookworm | skipping: Conditional result was False 2025-06-16 08:32:03.197472 | 2025-06-16 08:32:03.197598 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-16 08:32:03.898902 | debian-bookworm | changed 2025-06-16 08:32:03.906622 | 2025-06-16 08:32:03.906746 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-16 08:32:04.176203 | debian-bookworm | ok 2025-06-16 08:32:04.186134 | 2025-06-16 08:32:04.186358 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-16 08:32:04.890443 | debian-bookworm | changed 2025-06-16 08:32:04.897739 | 2025-06-16 08:32:04.897856 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-16 08:32:05.586797 | debian-bookworm | changed 2025-06-16 08:32:05.592504 | 2025-06-16 08:32:05.592611 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-16 08:32:05.617427 | debian-bookworm | skipping: Conditional result was False 2025-06-16 08:32:05.626765 | 2025-06-16 08:32:05.626926 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-16 08:32:06.078498 | debian-bookworm -> localhost | changed 2025-06-16 08:32:06.097010 | 2025-06-16 08:32:06.097171 | TASK [add-build-sshkey : Add back temp key] 2025-06-16 08:32:06.466514 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e544f3fe413c414594c128bff1a92f1a/work/e544f3fe413c414594c128bff1a92f1a_id_rsa (zuul-build-sshkey) 2025-06-16 08:32:06.467270 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017462 2025-06-16 08:32:06.482579 | 2025-06-16 08:32:06.482723 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-16 08:32:06.902473 | debian-bookworm | ok 2025-06-16 08:32:06.910694 | 2025-06-16 08:32:06.910889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-16 08:32:06.946138 | debian-bookworm | skipping: Conditional result was False 2025-06-16 08:32:06.962877 | 2025-06-16 08:32:06.963034 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-16 08:32:07.435149 | debian-bookworm | ok 2025-06-16 08:32:07.448123 | 2025-06-16 08:32:07.448322 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-16 08:32:07.495461 | debian-bookworm | ok 2025-06-16 08:32:07.504326 | 2025-06-16 08:32:07.504510 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-16 08:32:07.854121 | debian-bookworm -> localhost | ok 2025-06-16 08:32:07.860898 | 2025-06-16 08:32:07.861006 | TASK [validate-host : Collect information about the host] 2025-06-16 08:32:09.064465 | debian-bookworm | ok 2025-06-16 08:32:09.075052 | 2025-06-16 08:32:09.075187 | TASK [validate-host : Sanitize hostname] 2025-06-16 08:32:09.206011 | debian-bookworm | ok 2025-06-16 08:32:09.250950 | 2025-06-16 08:32:09.251091 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-16 08:32:09.873711 | debian-bookworm -> localhost | changed 2025-06-16 08:32:09.886222 | 2025-06-16 08:32:09.886403 | TASK [validate-host : Collect information about zuul worker] 2025-06-16 08:32:10.334213 | debian-bookworm | ok 2025-06-16 08:32:10.343147 | 2025-06-16 08:32:10.343340 | TASK [validate-host : Write out all zuul information for each host] 2025-06-16 08:32:10.929325 | debian-bookworm -> localhost | changed 2025-06-16 08:32:10.939507 | 2025-06-16 08:32:10.939623 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-16 08:32:11.230627 | debian-bookworm | ok 2025-06-16 08:32:11.239993 | 2025-06-16 08:32:11.240131 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-16 08:32:12.326938 | debian-bookworm | changed: 2025-06-16 08:32:12.327675 | debian-bookworm | cd+++++++++ src/ 2025-06-16 08:32:12.327767 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-16 08:32:12.327821 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-16 08:32:12.327869 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-16 08:32:12.327921 | debian-bookworm | Containerfile 2025-06-16 08:32:12.328269 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006992 2025-06-16 08:35:43.509253 | 2025-06-16 08:35:43.509412 | TASK [upload-logs : Upload logs to log server] 2025-06-16 08:35:44.103678 | localhost | Output suppressed because no_log was given 2025-06-16 08:35:44.105675 | 2025-06-16 08:35:44.105778 | LOOP [upload-logs : Compress console log and json output] 2025-06-16 08:35:44.161520 | localhost | skipping: Conditional result was False 2025-06-16 08:35:44.167689 | localhost | skipping: Conditional result was False 2025-06-16 08:35:44.176698 | 2025-06-16 08:35:44.176976 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-16 08:35:44.230461 | localhost | skipping: Conditional result was False 2025-06-16 08:35:44.230727 | 2025-06-16 08:35:44.235946 | localhost | skipping: Conditional result was False 2025-06-16 08:35:44.250142 | 2025-06-16 08:35:44.250366 | LOOP [upload-logs : Upload console log and json output]