2025-07-01 23:52:53.533904 | Job console starting 2025-07-01 23:52:53.543593 | Updating git repos 2025-07-01 23:52:53.570972 | Cloning repos into workspace 2025-07-01 23:52:53.604784 | Restoring repo states 2025-07-01 23:52:53.618005 | Merging changes 2025-07-01 23:52:54.131838 | Checking out repos 2025-07-01 23:52:54.177047 | Preparing playbooks 2025-07-01 23:52:54.811410 | Running Ansible setup 2025-07-01 23:52:59.254921 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-01 23:53:00.083780 | 2025-07-01 23:53:00.083953 | PLAY [Base pre] 2025-07-01 23:53:00.104554 | 2025-07-01 23:53:00.104701 | TASK [Setup log path fact] 2025-07-01 23:53:00.123729 | debian-bookworm | ok 2025-07-01 23:53:00.139837 | 2025-07-01 23:53:00.139999 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-01 23:53:00.169868 | debian-bookworm | ok 2025-07-01 23:53:00.179736 | 2025-07-01 23:53:00.179855 | TASK [emit-job-header : Print job information] 2025-07-01 23:53:00.226799 | # Job Information 2025-07-01 23:53:00.227141 | Ansible Version: 2.16.14 2025-07-01 23:53:00.227205 | Job: container-image-inventory-reconciler-build 2025-07-01 23:53:00.227263 | Pipeline: check 2025-07-01 23:53:00.227302 | Executor: 521e9411259a 2025-07-01 23:53:00.227338 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/397 2025-07-01 23:53:00.227376 | Event ID: 6840e980-56d6-11f0-987e-9a84c1d22f1a 2025-07-01 23:53:00.235538 | 2025-07-01 23:53:00.235700 | LOOP [emit-job-header : Print node information] 2025-07-01 23:53:00.344954 | debian-bookworm | ok: 2025-07-01 23:53:00.345160 | debian-bookworm | # Node Information 2025-07-01 23:53:00.345195 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-01 23:53:00.345220 | debian-bookworm | Hostname: debian 2025-07-01 23:53:00.345241 | debian-bookworm | Username: zuul 2025-07-01 23:53:00.345262 | debian-bookworm | Distro: Debian 12.11 2025-07-01 23:53:00.345287 | debian-bookworm | Provider: regiocloud-a 2025-07-01 23:53:00.345308 | debian-bookworm | Region: 2025-07-01 23:53:00.345330 | debian-bookworm | Label: debian-bookworm 2025-07-01 23:53:00.345350 | debian-bookworm | Product Name: OpenStack Nova 2025-07-01 23:53:00.345369 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe82:9dcd 2025-07-01 23:53:00.366490 | 2025-07-01 23:53:00.366654 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-01 23:53:01.007173 | debian-bookworm -> localhost | changed 2025-07-01 23:53:01.014964 | 2025-07-01 23:53:01.015107 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-01 23:53:02.258599 | debian-bookworm -> localhost | changed 2025-07-01 23:53:02.269783 | 2025-07-01 23:53:02.269922 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-01 23:53:02.579644 | debian-bookworm -> localhost | ok 2025-07-01 23:53:02.596065 | 2025-07-01 23:53:02.596209 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-01 23:53:02.635203 | debian-bookworm | ok 2025-07-01 23:53:02.674977 | debian-bookworm | included: /var/lib/zuul/builds/22ec2a57e15b4e48812dd9deb3fd93d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-01 23:53:02.681983 | 2025-07-01 23:53:02.682118 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-01 23:53:04.227971 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-01 23:53:04.228451 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/22ec2a57e15b4e48812dd9deb3fd93d3/work/22ec2a57e15b4e48812dd9deb3fd93d3_id_rsa 2025-07-01 23:53:04.228541 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/22ec2a57e15b4e48812dd9deb3fd93d3/work/22ec2a57e15b4e48812dd9deb3fd93d3_id_rsa.pub 2025-07-01 23:53:04.228595 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-01 23:53:04.228646 | debian-bookworm -> localhost | SHA256:U8m8rbxL86tfzWtrIews6O47gdsUmXbopIvKmTufdEI zuul-build-sshkey 2025-07-01 23:53:04.228709 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-01 23:53:04.228755 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-01 23:53:04.228798 | debian-bookworm -> localhost | | | 2025-07-01 23:53:04.228843 | debian-bookworm -> localhost | | o . | 2025-07-01 23:53:04.228914 | debian-bookworm -> localhost | | O | 2025-07-01 23:53:04.228957 | debian-bookworm -> localhost | | O + | 2025-07-01 23:53:04.228998 | debian-bookworm -> localhost | | E S + o | 2025-07-01 23:53:04.229047 | debian-bookworm -> localhost | | . o * . o + | 2025-07-01 23:53:04.229088 | debian-bookworm -> localhost | | o..= B o o +| 2025-07-01 23:53:04.229128 | debian-bookworm -> localhost | | ..+.+o = = + o.| 2025-07-01 23:53:04.229170 | debian-bookworm -> localhost | | *=o +=*+=.oo.| 2025-07-01 23:53:04.229212 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-01 23:53:04.229322 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.612813 2025-07-01 23:53:04.240723 | 2025-07-01 23:53:04.241201 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-01 23:53:04.273172 | debian-bookworm | ok 2025-07-01 23:53:04.285063 | debian-bookworm | included: /var/lib/zuul/builds/22ec2a57e15b4e48812dd9deb3fd93d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-01 23:53:04.295615 | 2025-07-01 23:53:04.295725 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-01 23:53:04.332580 | debian-bookworm | skipping: Conditional result was False 2025-07-01 23:53:04.343594 | 2025-07-01 23:53:04.343783 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-01 23:53:05.067548 | debian-bookworm | changed 2025-07-01 23:53:05.076077 | 2025-07-01 23:53:05.076248 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-01 23:53:05.359694 | debian-bookworm | ok 2025-07-01 23:53:05.367126 | 2025-07-01 23:53:05.367259 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-01 23:53:06.074940 | debian-bookworm | changed 2025-07-01 23:53:06.082311 | 2025-07-01 23:53:06.082467 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-01 23:53:06.732778 | debian-bookworm | changed 2025-07-01 23:53:06.739403 | 2025-07-01 23:53:06.739522 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-01 23:53:06.763873 | debian-bookworm | skipping: Conditional result was False 2025-07-01 23:53:06.771154 | 2025-07-01 23:53:06.771266 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-01 23:53:07.305754 | debian-bookworm -> localhost | changed 2025-07-01 23:53:07.317737 | 2025-07-01 23:53:07.318931 | TASK [add-build-sshkey : Add back temp key] 2025-07-01 23:53:07.677501 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/22ec2a57e15b4e48812dd9deb3fd93d3/work/22ec2a57e15b4e48812dd9deb3fd93d3_id_rsa (zuul-build-sshkey) 2025-07-01 23:53:07.677767 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014826 2025-07-01 23:53:07.687401 | 2025-07-01 23:53:07.687528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-01 23:53:08.171335 | debian-bookworm | ok 2025-07-01 23:53:08.180375 | 2025-07-01 23:53:08.180598 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-01 23:53:08.219440 | debian-bookworm | skipping: Conditional result was False 2025-07-01 23:53:08.234352 | 2025-07-01 23:53:08.234541 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-01 23:53:08.757215 | debian-bookworm | ok 2025-07-01 23:53:08.771275 | 2025-07-01 23:53:08.771456 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-01 23:53:08.802659 | debian-bookworm | ok 2025-07-01 23:53:08.809014 | 2025-07-01 23:53:08.809124 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-01 23:53:09.131272 | debian-bookworm -> localhost | ok 2025-07-01 23:53:09.139290 | 2025-07-01 23:53:09.139463 | TASK [validate-host : Collect information about the host] 2025-07-01 23:53:10.286291 | debian-bookworm | ok 2025-07-01 23:53:10.300722 | 2025-07-01 23:53:10.300907 | TASK [validate-host : Sanitize hostname] 2025-07-01 23:53:10.450221 | debian-bookworm | ok 2025-07-01 23:53:10.502013 | 2025-07-01 23:53:10.502462 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-01 23:53:11.097632 | debian-bookworm -> localhost | changed 2025-07-01 23:53:11.103766 | 2025-07-01 23:53:11.103883 | TASK [validate-host : Collect information about zuul worker] 2025-07-01 23:53:11.581112 | debian-bookworm | ok 2025-07-01 23:53:11.587888 | 2025-07-01 23:53:11.588012 | TASK [validate-host : Write out all zuul information for each host] 2025-07-01 23:53:12.121944 | debian-bookworm -> localhost | changed 2025-07-01 23:53:12.132509 | 2025-07-01 23:53:12.132637 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-01 23:53:12.403870 | debian-bookworm | ok 2025-07-01 23:53:12.412706 | 2025-07-01 23:53:12.412834 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-01 23:53:13.220087 | debian-bookworm | changed: 2025-07-01 23:53:13.220462 | debian-bookworm | cd+++++++++ src/ 2025-07-01 23:53:13.220540 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-01 23:53:13.220593 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-01 23:53:13.220640 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-07-01 23:53:13.220685 | debian-bookworm | Containerfile 2025-07-01 23:53:13.221118 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004165 2025-07-01 23:54:43.698399 | 2025-07-01 23:54:43.698552 | TASK [upload-logs : Upload logs to log server] 2025-07-01 23:54:44.277253 | localhost | Output suppressed because no_log was given 2025-07-01 23:54:44.280398 | 2025-07-01 23:54:44.280560 | LOOP [upload-logs : Compress console log and json output] 2025-07-01 23:54:44.340689 | localhost | skipping: Conditional result was False 2025-07-01 23:54:44.346500 | localhost | skipping: Conditional result was False 2025-07-01 23:54:44.361575 | 2025-07-01 23:54:44.361741 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-01 23:54:44.423927 | localhost | skipping: Conditional result was False 2025-07-01 23:54:44.424228 | 2025-07-01 23:54:44.428900 | localhost | skipping: Conditional result was False 2025-07-01 23:54:44.436231 | 2025-07-01 23:54:44.436533 | LOOP [upload-logs : Upload console log and json output]