2025-10-24 20:45:01.903487 | Job console starting 2025-10-24 20:45:01.935034 | Updating git repos 2025-10-24 20:45:01.970681 | Cloning repos into workspace 2025-10-24 20:45:02.033690 | Restoring repo states 2025-10-24 20:45:02.039458 | Merging changes 2025-10-24 20:45:02.537200 | Checking out repos 2025-10-24 20:45:02.591769 | Preparing playbooks 2025-10-24 20:45:03.754662 | Running Ansible setup 2025-10-24 20:45:08.699941 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-24 20:45:09.620559 | 2025-10-24 20:45:09.620720 | PLAY [Base pre] 2025-10-24 20:45:09.644865 | 2025-10-24 20:45:09.645045 | TASK [Setup log path fact] 2025-10-24 20:45:09.664369 | debian-bookworm | ok 2025-10-24 20:45:09.680477 | 2025-10-24 20:45:09.680634 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-24 20:45:09.710345 | debian-bookworm | ok 2025-10-24 20:45:09.720214 | 2025-10-24 20:45:09.720334 | TASK [emit-job-header : Print job information] 2025-10-24 20:45:09.770315 | # Job Information 2025-10-24 20:45:09.770517 | Ansible Version: 2.16.14 2025-10-24 20:45:09.770554 | Job: container-image-inventory-reconciler-build 2025-10-24 20:45:09.770587 | Pipeline: check 2025-10-24 20:45:09.770610 | Executor: 521e9411259a 2025-10-24 20:45:09.770631 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/438 2025-10-24 20:45:09.770653 | Event ID: 4a8a2980-b11a-11f0-9667-c460c6498cc5 2025-10-24 20:45:09.780551 | 2025-10-24 20:45:09.780699 | LOOP [emit-job-header : Print node information] 2025-10-24 20:45:09.978318 | debian-bookworm | ok: 2025-10-24 20:45:09.978567 | debian-bookworm | # Node Information 2025-10-24 20:45:09.978607 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-24 20:45:09.978633 | debian-bookworm | Hostname: debian 2025-10-24 20:45:09.978656 | debian-bookworm | Username: zuul 2025-10-24 20:45:09.978677 | debian-bookworm | Distro: Debian 12.12 2025-10-24 20:45:09.978701 | debian-bookworm | Provider: regiocloud-a 2025-10-24 20:45:09.978722 | debian-bookworm | Region: 2025-10-24 20:45:09.978743 | debian-bookworm | Label: debian-bookworm 2025-10-24 20:45:09.978762 | debian-bookworm | Product Name: OpenStack Nova 2025-10-24 20:45:09.978782 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:8ccc 2025-10-24 20:45:10.008283 | 2025-10-24 20:45:10.008444 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-24 20:45:10.713523 | debian-bookworm -> localhost | changed 2025-10-24 20:45:10.721406 | 2025-10-24 20:45:10.721542 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-24 20:45:12.234641 | debian-bookworm -> localhost | changed 2025-10-24 20:45:12.244647 | 2025-10-24 20:45:12.244739 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-24 20:45:12.509175 | debian-bookworm -> localhost | ok 2025-10-24 20:45:12.514957 | 2025-10-24 20:45:12.515058 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-24 20:45:12.552270 | debian-bookworm | ok 2025-10-24 20:45:12.580307 | debian-bookworm | included: /var/lib/zuul/builds/67b4b94f7c8944d291a1d0148c4f34c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-24 20:45:12.585902 | 2025-10-24 20:45:12.585995 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-24 20:45:13.413779 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-24 20:45:13.413986 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/67b4b94f7c8944d291a1d0148c4f34c2/work/67b4b94f7c8944d291a1d0148c4f34c2_id_rsa 2025-10-24 20:45:13.414026 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/67b4b94f7c8944d291a1d0148c4f34c2/work/67b4b94f7c8944d291a1d0148c4f34c2_id_rsa.pub 2025-10-24 20:45:13.414053 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-24 20:45:13.414077 | debian-bookworm -> localhost | SHA256:m5+xZDClKT4/0Np9b3WXYW2VSQEJnrDh9irjZt3g+vU zuul-build-sshkey 2025-10-24 20:45:13.414110 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-24 20:45:13.414133 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-24 20:45:13.414154 | debian-bookworm -> localhost | | o ...+o+| 2025-10-24 20:45:13.414175 | debian-bookworm -> localhost | | . = .. o.| 2025-10-24 20:45:13.414196 | debian-bookworm -> localhost | | +.o o| 2025-10-24 20:45:13.414216 | debian-bookworm -> localhost | | .+. oo| 2025-10-24 20:45:13.414236 | debian-bookworm -> localhost | | ..S . ..o| 2025-10-24 20:45:13.414263 | debian-bookworm -> localhost | | ....*. .+| 2025-10-24 20:45:13.414284 | debian-bookworm -> localhost | | o*=o*. .o| 2025-10-24 20:45:13.414304 | debian-bookworm -> localhost | | o==*o=o . | 2025-10-24 20:45:13.414324 | debian-bookworm -> localhost | | oo+o+. E. | 2025-10-24 20:45:13.414344 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-24 20:45:13.414392 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.286391 2025-10-24 20:45:13.420441 | 2025-10-24 20:45:13.420529 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-24 20:45:13.438124 | debian-bookworm | ok 2025-10-24 20:45:13.446988 | debian-bookworm | included: /var/lib/zuul/builds/67b4b94f7c8944d291a1d0148c4f34c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-24 20:45:13.455527 | 2025-10-24 20:45:13.455623 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-24 20:45:13.468518 | debian-bookworm | skipping: Conditional result was False 2025-10-24 20:45:13.474201 | 2025-10-24 20:45:13.474288 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-24 20:45:14.067338 | debian-bookworm | changed 2025-10-24 20:45:14.074785 | 2025-10-24 20:45:14.074912 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-24 20:45:14.371118 | debian-bookworm | ok 2025-10-24 20:45:14.383769 | 2025-10-24 20:45:14.383909 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-24 20:45:15.052661 | debian-bookworm | changed 2025-10-24 20:45:15.064216 | 2025-10-24 20:45:15.064412 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-24 20:45:15.678490 | debian-bookworm | changed 2025-10-24 20:45:15.682790 | 2025-10-24 20:45:15.682896 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-24 20:45:15.705365 | debian-bookworm | skipping: Conditional result was False 2025-10-24 20:45:15.710037 | 2025-10-24 20:45:15.710115 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-24 20:45:16.149882 | debian-bookworm -> localhost | changed 2025-10-24 20:45:16.158321 | 2025-10-24 20:45:16.158401 | TASK [add-build-sshkey : Add back temp key] 2025-10-24 20:45:16.525486 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/67b4b94f7c8944d291a1d0148c4f34c2/work/67b4b94f7c8944d291a1d0148c4f34c2_id_rsa (zuul-build-sshkey) 2025-10-24 20:45:16.525697 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011932 2025-10-24 20:45:16.532877 | 2025-10-24 20:45:16.532976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-24 20:45:16.884322 | debian-bookworm | ok 2025-10-24 20:45:16.889155 | 2025-10-24 20:45:16.889240 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-24 20:45:16.922341 | debian-bookworm | skipping: Conditional result was False 2025-10-24 20:45:16.932567 | 2025-10-24 20:45:16.932652 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-24 20:45:17.364480 | debian-bookworm | ok 2025-10-24 20:45:17.374625 | 2025-10-24 20:45:17.374719 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-24 20:45:17.403049 | debian-bookworm | ok 2025-10-24 20:45:17.407864 | 2025-10-24 20:45:17.407981 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-24 20:45:17.664040 | debian-bookworm -> localhost | ok 2025-10-24 20:45:17.670384 | 2025-10-24 20:45:17.670495 | TASK [validate-host : Collect information about the host] 2025-10-24 20:45:18.713030 | debian-bookworm | ok 2025-10-24 20:45:18.722821 | 2025-10-24 20:45:18.722952 | TASK [validate-host : Sanitize hostname] 2025-10-24 20:45:18.831866 | debian-bookworm | ok 2025-10-24 20:45:18.864899 | 2025-10-24 20:45:18.865041 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-24 20:45:19.408803 | debian-bookworm -> localhost | changed 2025-10-24 20:45:19.414018 | 2025-10-24 20:45:19.414108 | TASK [validate-host : Collect information about zuul worker] 2025-10-24 20:45:19.822502 | debian-bookworm | ok 2025-10-24 20:45:19.828112 | 2025-10-24 20:45:19.828293 | TASK [validate-host : Write out all zuul information for each host] 2025-10-24 20:45:20.376564 | debian-bookworm -> localhost | changed 2025-10-24 20:45:20.385816 | 2025-10-24 20:45:20.385914 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-24 20:45:20.645149 | debian-bookworm | ok 2025-10-24 20:45:20.650373 | 2025-10-24 20:45:20.650460 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-24 20:45:21.580639 | debian-bookworm | changed: 2025-10-24 20:45:21.580804 | debian-bookworm | cd+++++++++ src/ 2025-10-24 20:45:21.580838 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-24 20:45:21.580862 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-24 20:45:21.580884 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-10-24 20:45:21.580903 | debian-bookworm | Containerfile 2025-10-24 20:45:21.581045 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006794 2025-10-24 20:46:58.509265 | 2025-10-24 20:46:58.509380 | TASK [upload-logs : Upload logs to log server] 2025-10-24 20:46:59.064616 | localhost | Output suppressed because no_log was given 2025-10-24 20:46:59.068858 | 2025-10-24 20:46:59.069059 | LOOP [upload-logs : Compress console log and json output] 2025-10-24 20:46:59.120595 | localhost | skipping: Conditional result was False 2025-10-24 20:46:59.136595 | localhost | skipping: Conditional result was False 2025-10-24 20:46:59.148417 | 2025-10-24 20:46:59.148564 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-24 20:46:59.203621 | localhost | skipping: Conditional result was False 2025-10-24 20:46:59.204234 | 2025-10-24 20:46:59.207527 | localhost | skipping: Conditional result was False 2025-10-24 20:46:59.221428 | 2025-10-24 20:46:59.221671 | LOOP [upload-logs : Upload console log and json output]