2025-10-25 16:35:37.500777 | Job console starting 2025-10-25 16:35:37.516214 | Updating git repos 2025-10-25 16:35:37.550260 | Cloning repos into workspace 2025-10-25 16:35:37.582789 | Restoring repo states 2025-10-25 16:35:37.590304 | Merging changes 2025-10-25 16:35:38.066661 | Checking out repos 2025-10-25 16:35:38.169664 | Preparing playbooks 2025-10-25 16:35:39.094346 | Running Ansible setup 2025-10-25 16:35:44.020863 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-25 16:35:45.049516 | 2025-10-25 16:35:45.051233 | PLAY [Base pre] 2025-10-25 16:35:45.068117 | 2025-10-25 16:35:45.068254 | TASK [Setup log path fact] 2025-10-25 16:35:45.097604 | debian-bookworm | ok 2025-10-25 16:35:45.113415 | 2025-10-25 16:35:45.113577 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-25 16:35:45.164447 | debian-bookworm | ok 2025-10-25 16:35:45.184885 | 2025-10-25 16:35:45.185057 | TASK [emit-job-header : Print job information] 2025-10-25 16:35:45.257222 | # Job Information 2025-10-25 16:35:45.257412 | Ansible Version: 2.16.14 2025-10-25 16:35:45.257449 | Job: container-image-inventory-reconciler-build 2025-10-25 16:35:45.257482 | Pipeline: check 2025-10-25 16:35:45.257505 | Executor: 521e9411259a 2025-10-25 16:35:45.257526 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/441 2025-10-25 16:35:45.257547 | Event ID: 9dc3afd0-b1c0-11f0-9fff-0551270c5a11 2025-10-25 16:35:45.262705 | 2025-10-25 16:35:45.262826 | LOOP [emit-job-header : Print node information] 2025-10-25 16:35:45.390756 | debian-bookworm | ok: 2025-10-25 16:35:45.392063 | debian-bookworm | # Node Information 2025-10-25 16:35:45.392151 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-25 16:35:45.392181 | debian-bookworm | Hostname: debian 2025-10-25 16:35:45.392205 | debian-bookworm | Username: zuul 2025-10-25 16:35:45.392226 | debian-bookworm | Distro: Debian 12.12 2025-10-25 16:35:45.392250 | debian-bookworm | Provider: regiocloud-a 2025-10-25 16:35:45.392271 | debian-bookworm | Region: 2025-10-25 16:35:45.392293 | debian-bookworm | Label: debian-bookworm 2025-10-25 16:35:45.392314 | debian-bookworm | Product Name: OpenStack Nova 2025-10-25 16:35:45.392333 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe39:a6f9 2025-10-25 16:35:45.405733 | 2025-10-25 16:35:45.405858 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-25 16:35:46.102517 | debian-bookworm -> localhost | changed 2025-10-25 16:35:46.109343 | 2025-10-25 16:35:46.109440 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-25 16:35:47.187590 | debian-bookworm -> localhost | changed 2025-10-25 16:35:47.197600 | 2025-10-25 16:35:47.197695 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-25 16:35:47.564025 | debian-bookworm -> localhost | ok 2025-10-25 16:35:47.569737 | 2025-10-25 16:35:47.569835 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-25 16:35:47.597021 | debian-bookworm | ok 2025-10-25 16:35:47.623768 | debian-bookworm | included: /var/lib/zuul/builds/d7dce1ff89c44514b7ae80ef6fd32f7a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-25 16:35:47.629414 | 2025-10-25 16:35:47.629495 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-25 16:35:49.138889 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-25 16:35:49.139274 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d7dce1ff89c44514b7ae80ef6fd32f7a/work/d7dce1ff89c44514b7ae80ef6fd32f7a_id_rsa 2025-10-25 16:35:49.139343 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d7dce1ff89c44514b7ae80ef6fd32f7a/work/d7dce1ff89c44514b7ae80ef6fd32f7a_id_rsa.pub 2025-10-25 16:35:49.139387 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-25 16:35:49.139428 | debian-bookworm -> localhost | SHA256:cXWVsuDiLhvVgWlJ6MGiaeQbhwLzwtqCLwfNkR0ZA6o zuul-build-sshkey 2025-10-25 16:35:49.139477 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-25 16:35:49.139514 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-25 16:35:49.139549 | debian-bookworm -> localhost | | ..oo. .. . ..o| 2025-10-25 16:35:49.139584 | debian-bookworm -> localhost | |o. .oo +. +o o . | 2025-10-25 16:35:49.139618 | debian-bookworm -> localhost | |+ooo+.o o=o.. o | 2025-10-25 16:35:49.139649 | debian-bookworm -> localhost | |oo+B.. ..+.... | 2025-10-25 16:35:49.139681 | debian-bookworm -> localhost | |E=o.+ S... | 2025-10-25 16:35:49.139725 | debian-bookworm -> localhost | |= +. .. | 2025-10-25 16:35:49.139758 | debian-bookworm -> localhost | | + .. | 2025-10-25 16:35:49.139790 | debian-bookworm -> localhost | |. o ... | 2025-10-25 16:35:49.139824 | debian-bookworm -> localhost | | o .o | 2025-10-25 16:35:49.139859 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-25 16:35:49.139947 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.841916 2025-10-25 16:35:49.151194 | 2025-10-25 16:35:49.151379 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-25 16:35:49.185842 | debian-bookworm | ok 2025-10-25 16:35:49.198643 | debian-bookworm | included: /var/lib/zuul/builds/d7dce1ff89c44514b7ae80ef6fd32f7a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-25 16:35:49.207459 | 2025-10-25 16:35:49.207537 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-25 16:35:49.240281 | debian-bookworm | skipping: Conditional result was False 2025-10-25 16:35:49.246367 | 2025-10-25 16:35:49.246448 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-25 16:35:49.919713 | debian-bookworm | changed 2025-10-25 16:35:49.928338 | 2025-10-25 16:35:49.928461 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-25 16:35:50.230297 | debian-bookworm | ok 2025-10-25 16:35:50.236703 | 2025-10-25 16:35:50.236804 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-25 16:35:50.883810 | debian-bookworm | changed 2025-10-25 16:35:50.890080 | 2025-10-25 16:35:50.890163 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-25 16:35:51.517621 | debian-bookworm | changed 2025-10-25 16:35:51.522755 | 2025-10-25 16:35:51.529507 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-25 16:35:51.552939 | debian-bookworm | skipping: Conditional result was False 2025-10-25 16:35:51.558547 | 2025-10-25 16:35:51.558633 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-25 16:35:51.963126 | debian-bookworm -> localhost | changed 2025-10-25 16:35:51.973239 | 2025-10-25 16:35:51.973335 | TASK [add-build-sshkey : Add back temp key] 2025-10-25 16:35:52.258699 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d7dce1ff89c44514b7ae80ef6fd32f7a/work/d7dce1ff89c44514b7ae80ef6fd32f7a_id_rsa (zuul-build-sshkey) 2025-10-25 16:35:52.258919 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017806 2025-10-25 16:35:52.266208 | 2025-10-25 16:35:52.266349 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-25 16:35:52.648303 | debian-bookworm | ok 2025-10-25 16:35:52.654774 | 2025-10-25 16:35:52.654874 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-25 16:35:52.677602 | debian-bookworm | skipping: Conditional result was False 2025-10-25 16:35:52.687522 | 2025-10-25 16:35:52.687614 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-25 16:35:53.122105 | debian-bookworm | ok 2025-10-25 16:35:53.134470 | 2025-10-25 16:35:53.134611 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-25 16:35:53.163588 | debian-bookworm | ok 2025-10-25 16:35:53.170196 | 2025-10-25 16:35:53.170326 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-25 16:35:53.454679 | debian-bookworm -> localhost | ok 2025-10-25 16:35:53.465555 | 2025-10-25 16:35:53.465700 | TASK [validate-host : Collect information about the host] 2025-10-25 16:35:54.581189 | debian-bookworm | ok 2025-10-25 16:35:54.591306 | 2025-10-25 16:35:54.591435 | TASK [validate-host : Sanitize hostname] 2025-10-25 16:35:54.692421 | debian-bookworm | ok 2025-10-25 16:35:54.734758 | 2025-10-25 16:35:54.734914 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-25 16:35:55.319267 | debian-bookworm -> localhost | changed 2025-10-25 16:35:55.325233 | 2025-10-25 16:35:55.325360 | TASK [validate-host : Collect information about zuul worker] 2025-10-25 16:35:55.768216 | debian-bookworm | ok 2025-10-25 16:35:55.773004 | 2025-10-25 16:35:55.773119 | TASK [validate-host : Write out all zuul information for each host] 2025-10-25 16:35:56.324519 | debian-bookworm -> localhost | changed 2025-10-25 16:35:56.334319 | 2025-10-25 16:35:56.334437 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-25 16:35:56.604985 | debian-bookworm | ok 2025-10-25 16:35:56.610642 | 2025-10-25 16:35:56.610751 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-25 16:35:57.391002 | debian-bookworm | changed: 2025-10-25 16:35:57.391210 | debian-bookworm | cd+++++++++ src/ 2025-10-25 16:35:57.391244 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-25 16:35:57.391268 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-25 16:35:57.391289 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-10-25 16:35:57.391309 | debian-bookworm | Containerfile 2025-10-25 16:35:57.391439 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006554 2025-10-25 16:37:32.185855 | 2025-10-25 16:37:32.186137 | TASK [upload-logs : Upload logs to log server] 2025-10-25 16:37:32.737338 | localhost | Output suppressed because no_log was given 2025-10-25 16:37:32.741975 | 2025-10-25 16:37:32.742166 | LOOP [upload-logs : Compress console log and json output] 2025-10-25 16:37:32.796276 | localhost | skipping: Conditional result was False 2025-10-25 16:37:32.801856 | localhost | skipping: Conditional result was False 2025-10-25 16:37:32.815326 | 2025-10-25 16:37:32.815566 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-25 16:37:32.861956 | localhost | skipping: Conditional result was False 2025-10-25 16:37:32.862307 | 2025-10-25 16:37:32.866668 | localhost | skipping: Conditional result was False 2025-10-25 16:37:32.880060 | 2025-10-25 16:37:32.880272 | LOOP [upload-logs : Upload console log and json output]