2026-02-25 21:01:40.161892 | Job console starting 2026-02-25 21:01:40.179718 | Updating git repos 2026-02-25 21:01:40.199312 | Cloning repos into workspace 2026-02-25 21:01:40.252203 | Restoring repo states 2026-02-25 21:01:40.261813 | Merging changes 2026-02-25 21:01:40.717244 | Checking out repos 2026-02-25 21:01:40.780277 | Preparing playbooks 2026-02-25 21:01:41.587035 | Running Ansible setup 2026-02-25 21:01:46.405137 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-25 21:01:47.383756 | 2026-02-25 21:01:47.383930 | PLAY [Base pre] 2026-02-25 21:01:47.425710 | 2026-02-25 21:01:47.425873 | TASK [Setup log path fact] 2026-02-25 21:01:47.455045 | debian-bookworm | ok 2026-02-25 21:01:47.470342 | 2026-02-25 21:01:47.470494 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 21:01:47.520482 | debian-bookworm | ok 2026-02-25 21:01:47.530360 | 2026-02-25 21:01:47.530480 | TASK [emit-job-header : Print job information] 2026-02-25 21:01:47.592008 | # Job Information 2026-02-25 21:01:47.592199 | Ansible Version: 2.16.14 2026-02-25 21:01:47.592235 | Job: container-image-inventory-reconciler-build 2026-02-25 21:01:47.592269 | Pipeline: check 2026-02-25 21:01:47.592293 | Executor: 521e9411259a 2026-02-25 21:01:47.592330 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/503 2026-02-25 21:01:47.592353 | Event ID: 219b7180-128d-11f1-854d-32e69ec8316b 2026-02-25 21:01:47.597536 | 2026-02-25 21:01:47.597653 | LOOP [emit-job-header : Print node information] 2026-02-25 21:01:47.746589 | debian-bookworm | ok: 2026-02-25 21:01:47.746827 | debian-bookworm | # Node Information 2026-02-25 21:01:47.746908 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-25 21:01:47.746935 | debian-bookworm | Hostname: debian 2026-02-25 21:01:47.746958 | debian-bookworm | Username: zuul 2026-02-25 21:01:47.746979 | debian-bookworm | Distro: Debian 12.13 2026-02-25 21:01:47.747004 | debian-bookworm | Provider: regiocloud-a 2026-02-25 21:01:47.747025 | debian-bookworm | Region: 2026-02-25 21:01:47.747046 | debian-bookworm | Label: debian-bookworm 2026-02-25 21:01:47.747066 | debian-bookworm | Product Name: OpenStack Nova 2026-02-25 21:01:47.747085 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe23:53ef 2026-02-25 21:01:47.760978 | 2026-02-25 21:01:47.761115 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 21:01:48.530008 | debian-bookworm -> localhost | changed 2026-02-25 21:01:48.544766 | 2026-02-25 21:01:48.544911 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 21:01:49.814925 | debian-bookworm -> localhost | changed 2026-02-25 21:01:49.835208 | 2026-02-25 21:01:49.835325 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 21:01:50.117872 | debian-bookworm -> localhost | ok 2026-02-25 21:01:50.123692 | 2026-02-25 21:01:50.123787 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 21:01:50.140802 | debian-bookworm | ok 2026-02-25 21:01:50.168944 | debian-bookworm | included: /var/lib/zuul/builds/3a935e745ba24f54bd81a00ca9922688/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 21:01:50.174762 | 2026-02-25 21:01:50.174863 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 21:01:52.262156 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-25 21:01:52.262369 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a935e745ba24f54bd81a00ca9922688/work/3a935e745ba24f54bd81a00ca9922688_id_rsa 2026-02-25 21:01:52.262409 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a935e745ba24f54bd81a00ca9922688/work/3a935e745ba24f54bd81a00ca9922688_id_rsa.pub 2026-02-25 21:01:52.262435 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-25 21:01:52.262459 | debian-bookworm -> localhost | SHA256:0HRJ+q3Vr1at/84cvTbogBic6NKkwYsJiv4VGO7DOqU zuul-build-sshkey 2026-02-25 21:01:52.262490 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-25 21:01:52.262512 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-25 21:01:52.262533 | debian-bookworm -> localhost | | ..o. | 2026-02-25 21:01:52.262554 | debian-bookworm -> localhost | | o o. | 2026-02-25 21:01:52.262574 | debian-bookworm -> localhost | | . . o | 2026-02-25 21:01:52.262594 | debian-bookworm -> localhost | | o o o... . . | 2026-02-25 21:01:52.262614 | debian-bookworm -> localhost | |. = + +S . o . .| 2026-02-25 21:01:52.262640 | debian-bookworm -> localhost | |+ =.B . o .o .+| 2026-02-25 21:01:52.262661 | debian-bookworm -> localhost | |oooB + . ... .+o| 2026-02-25 21:01:52.262680 | debian-bookworm -> localhost | |.E. + ..o*o| 2026-02-25 21:01:52.262701 | debian-bookworm -> localhost | | oo. .oo+O| 2026-02-25 21:01:52.262721 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-25 21:01:52.262771 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.344971 2026-02-25 21:01:52.268772 | 2026-02-25 21:01:52.268862 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 21:01:52.302104 | debian-bookworm | ok 2026-02-25 21:01:52.309715 | debian-bookworm | included: /var/lib/zuul/builds/3a935e745ba24f54bd81a00ca9922688/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 21:01:52.321595 | 2026-02-25 21:01:52.321697 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 21:01:52.334446 | debian-bookworm | skipping: Conditional result was False 2026-02-25 21:01:52.339945 | 2026-02-25 21:01:52.340033 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 21:01:52.879548 | debian-bookworm | changed 2026-02-25 21:01:52.887676 | 2026-02-25 21:01:52.887785 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 21:01:53.136092 | debian-bookworm | ok 2026-02-25 21:01:53.144926 | 2026-02-25 21:01:53.145042 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 21:01:53.769984 | debian-bookworm | changed 2026-02-25 21:01:53.781794 | 2026-02-25 21:01:53.781953 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 21:01:54.405870 | debian-bookworm | changed 2026-02-25 21:01:54.414090 | 2026-02-25 21:01:54.414211 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 21:01:54.437447 | debian-bookworm | skipping: Conditional result was False 2026-02-25 21:01:54.443678 | 2026-02-25 21:01:54.443784 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 21:01:54.911120 | debian-bookworm -> localhost | changed 2026-02-25 21:01:54.921589 | 2026-02-25 21:01:54.921698 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 21:01:55.272239 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3a935e745ba24f54bd81a00ca9922688/work/3a935e745ba24f54bd81a00ca9922688_id_rsa (zuul-build-sshkey) 2026-02-25 21:01:55.272560 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016745 2026-02-25 21:01:55.281123 | 2026-02-25 21:01:55.281251 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 21:01:55.685204 | debian-bookworm | ok 2026-02-25 21:01:55.692496 | 2026-02-25 21:01:55.692678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 21:01:55.717239 | debian-bookworm | skipping: Conditional result was False 2026-02-25 21:01:55.743488 | 2026-02-25 21:01:55.743626 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 21:01:56.183231 | debian-bookworm | ok 2026-02-25 21:01:56.194350 | 2026-02-25 21:01:56.194469 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-25 21:01:56.235820 | debian-bookworm | ok 2026-02-25 21:01:56.241681 | 2026-02-25 21:01:56.241801 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-25 21:01:56.570464 | debian-bookworm -> localhost | ok 2026-02-25 21:01:56.577441 | 2026-02-25 21:01:56.577581 | TASK [validate-host : Collect information about the host] 2026-02-25 21:01:57.733774 | debian-bookworm | ok 2026-02-25 21:01:57.746366 | 2026-02-25 21:01:57.746501 | TASK [validate-host : Sanitize hostname] 2026-02-25 21:01:57.878148 | debian-bookworm | ok 2026-02-25 21:01:57.933001 | 2026-02-25 21:01:57.933142 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-25 21:01:58.534824 | debian-bookworm -> localhost | changed 2026-02-25 21:01:58.540869 | 2026-02-25 21:01:58.540993 | TASK [validate-host : Collect information about zuul worker] 2026-02-25 21:01:58.940919 | debian-bookworm | ok 2026-02-25 21:01:58.948270 | 2026-02-25 21:01:58.948466 | TASK [validate-host : Write out all zuul information for each host] 2026-02-25 21:01:59.594323 | debian-bookworm -> localhost | changed 2026-02-25 21:01:59.604049 | 2026-02-25 21:01:59.604167 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-25 21:01:59.866989 | debian-bookworm | ok 2026-02-25 21:01:59.875021 | 2026-02-25 21:01:59.875168 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-25 21:02:01.354164 | debian-bookworm | changed: 2026-02-25 21:02:01.354400 | debian-bookworm | cd+++++++++ src/ 2026-02-25 21:02:01.354440 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-25 21:02:01.354466 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-25 21:02:01.354488 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-02-25 21:02:01.354510 | debian-bookworm | Containerfile 2026-02-25 21:02:01.354668 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007575 2026-02-25 21:03:58.286115 | 2026-02-25 21:03:58.286401 | TASK [upload-logs : Upload logs to log server] 2026-02-25 21:03:58.882119 | localhost | Output suppressed because no_log was given 2026-02-25 21:03:58.884806 | 2026-02-25 21:03:58.884947 | LOOP [upload-logs : Compress console log and json output] 2026-02-25 21:03:58.941840 | localhost | skipping: Conditional result was False 2026-02-25 21:03:58.948667 | localhost | skipping: Conditional result was False 2026-02-25 21:03:58.953309 | 2026-02-25 21:03:58.953491 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-25 21:03:59.005877 | localhost | skipping: Conditional result was False 2026-02-25 21:03:59.006594 | 2026-02-25 21:03:59.009973 | localhost | skipping: Conditional result was False 2026-02-25 21:03:59.024989 | 2026-02-25 21:03:59.025107 | LOOP [upload-logs : Upload console log and json output]