2026-06-12 15:54:42.910757 | Job console starting 2026-06-12 15:54:42.924169 | Updating git repos 2026-06-12 15:54:42.973695 | Cloning repos into workspace 2026-06-12 15:54:43.069144 | Restoring repo states 2026-06-12 15:54:43.085171 | Merging changes 2026-06-12 15:54:43.621683 | Checking out repos 2026-06-12 15:54:43.695676 | Preparing playbooks 2026-06-12 15:54:45.149347 | Running Ansible setup 2026-06-12 15:54:50.843231 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-12 15:54:51.902504 | 2026-06-12 15:54:51.902721 | PLAY [Base pre] 2026-06-12 15:54:51.936432 | 2026-06-12 15:54:51.936625 | TASK [Setup log path fact] 2026-06-12 15:54:51.967820 | debian-bookworm | ok 2026-06-12 15:54:52.004769 | 2026-06-12 15:54:52.004968 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 15:54:52.034531 | debian-bookworm | ok 2026-06-12 15:54:52.052626 | 2026-06-12 15:54:52.052765 | TASK [emit-job-header : Print job information] 2026-06-12 15:54:52.137233 | # Job Information 2026-06-12 15:54:52.137439 | Ansible Version: 2.16.14 2026-06-12 15:54:52.137476 | Job: container-image-inventory-reconciler-build 2026-06-12 15:54:52.137511 | Pipeline: check 2026-06-12 15:54:52.137534 | Executor: 521e9411259a 2026-06-12 15:54:52.137573 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/553 2026-06-12 15:54:52.137595 | Event ID: 00c92680-6677-11f1-8589-5d3940967347 2026-06-12 15:54:52.151359 | 2026-06-12 15:54:52.151509 | LOOP [emit-job-header : Print node information] 2026-06-12 15:54:52.360825 | debian-bookworm | ok: 2026-06-12 15:54:52.363047 | debian-bookworm | # Node Information 2026-06-12 15:54:52.363130 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-12 15:54:52.363160 | debian-bookworm | Hostname: debian 2026-06-12 15:54:52.363183 | debian-bookworm | Username: zuul 2026-06-12 15:54:52.363205 | debian-bookworm | Distro: Debian 12.14 2026-06-12 15:54:52.363230 | debian-bookworm | Provider: regiocloud-a 2026-06-12 15:54:52.363251 | debian-bookworm | Region: 2026-06-12 15:54:52.363273 | debian-bookworm | Label: debian-bookworm 2026-06-12 15:54:52.363293 | debian-bookworm | Product Name: OpenStack Nova 2026-06-12 15:54:52.363313 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedd:2fec 2026-06-12 15:54:52.381222 | 2026-06-12 15:54:52.381355 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-12 15:54:53.303509 | debian-bookworm -> localhost | changed 2026-06-12 15:54:53.311094 | 2026-06-12 15:54:53.311224 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-12 15:54:54.733716 | debian-bookworm -> localhost | changed 2026-06-12 15:54:54.744219 | 2026-06-12 15:54:54.744327 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-12 15:54:55.145021 | debian-bookworm -> localhost | ok 2026-06-12 15:54:55.151341 | 2026-06-12 15:54:55.151440 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-12 15:54:55.190619 | debian-bookworm | ok 2026-06-12 15:54:55.212436 | debian-bookworm | included: /var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-12 15:54:55.219331 | 2026-06-12 15:54:55.219424 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-12 15:54:56.435438 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-12 15:54:56.435640 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/eb538c6e96a94706929e0db26bdf6342_id_rsa 2026-06-12 15:54:56.435678 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/eb538c6e96a94706929e0db26bdf6342_id_rsa.pub 2026-06-12 15:54:56.435704 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-12 15:54:56.435728 | debian-bookworm -> localhost | SHA256:eWS4kaKhl0iiQXVX9qQkI8KKNR5j7r4Wr5gvHp7aPnQ zuul-build-sshkey 2026-06-12 15:54:56.435761 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-12 15:54:56.435784 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-12 15:54:56.435805 | debian-bookworm -> localhost | | .oo o +.+ . | 2026-06-12 15:54:56.435826 | debian-bookworm -> localhost | |. *.o o =o+ | 2026-06-12 15:54:56.435846 | debian-bookworm -> localhost | |+=o+. . +.o. | 2026-06-12 15:54:56.435866 | debian-bookworm -> localhost | |o=oo + . * | 2026-06-12 15:54:56.435886 | debian-bookworm -> localhost | |..o + S . | 2026-06-12 15:54:56.435910 | debian-bookworm -> localhost | | +.E . | 2026-06-12 15:54:56.435931 | debian-bookworm -> localhost | | + + | 2026-06-12 15:54:56.435950 | debian-bookworm -> localhost | |o+* . | 2026-06-12 15:54:56.435971 | debian-bookworm -> localhost | |*O*+ | 2026-06-12 15:54:56.435991 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-12 15:54:56.436037 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.458762 2026-06-12 15:54:56.442686 | 2026-06-12 15:54:56.442782 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-12 15:54:56.461198 | debian-bookworm | ok 2026-06-12 15:54:56.473896 | debian-bookworm | included: /var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-12 15:54:56.482254 | 2026-06-12 15:54:56.482342 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-12 15:54:56.495149 | debian-bookworm | skipping: Conditional result was False 2026-06-12 15:54:56.502069 | 2026-06-12 15:54:56.502158 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-12 15:54:57.200333 | debian-bookworm | changed 2026-06-12 15:54:57.208671 | 2026-06-12 15:54:57.208780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-12 15:54:57.476873 | debian-bookworm | ok 2026-06-12 15:54:57.482322 | 2026-06-12 15:54:57.482416 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-12 15:54:58.114232 | debian-bookworm | changed 2026-06-12 15:54:58.120668 | 2026-06-12 15:54:58.120770 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-12 15:54:58.758705 | debian-bookworm | changed 2026-06-12 15:54:58.764511 | 2026-06-12 15:54:58.764630 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-12 15:54:58.777728 | debian-bookworm | skipping: Conditional result was False 2026-06-12 15:54:58.784331 | 2026-06-12 15:54:58.784441 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-12 15:54:59.223271 | debian-bookworm -> localhost | changed 2026-06-12 15:54:59.233951 | 2026-06-12 15:54:59.234052 | TASK [add-build-sshkey : Add back temp key] 2026-06-12 15:54:59.571320 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/eb538c6e96a94706929e0db26bdf6342_id_rsa (zuul-build-sshkey) 2026-06-12 15:54:59.571608 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010561 2026-06-12 15:54:59.581554 | 2026-06-12 15:54:59.581719 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-12 15:54:59.986164 | debian-bookworm | ok 2026-06-12 15:54:59.999643 | 2026-06-12 15:54:59.999783 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-12 15:55:00.024715 | debian-bookworm | skipping: Conditional result was False 2026-06-12 15:55:00.036037 | 2026-06-12 15:55:00.036170 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-12 15:55:00.544023 | debian-bookworm | ok 2026-06-12 15:55:00.564251 | 2026-06-12 15:55:00.564398 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-12 15:55:00.624216 | debian-bookworm | ok 2026-06-12 15:55:00.629820 | 2026-06-12 15:55:00.629942 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-12 15:55:01.072296 | debian-bookworm -> localhost | ok 2026-06-12 15:55:01.080057 | 2026-06-12 15:55:01.080257 | TASK [validate-host : Collect information about the host] 2026-06-12 15:55:02.219818 | debian-bookworm | ok 2026-06-12 15:55:02.231790 | 2026-06-12 15:55:02.231917 | TASK [validate-host : Sanitize hostname] 2026-06-12 15:55:02.383107 | debian-bookworm | ok 2026-06-12 15:55:02.388565 | 2026-06-12 15:55:02.388734 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-12 15:55:02.989543 | debian-bookworm -> localhost | changed 2026-06-12 15:55:02.996732 | 2026-06-12 15:55:02.996861 | TASK [validate-host : Collect information about zuul worker] 2026-06-12 15:55:03.501722 | debian-bookworm | ok 2026-06-12 15:55:03.510082 | 2026-06-12 15:55:03.510211 | TASK [validate-host : Write out all zuul information for each host] 2026-06-12 15:55:04.218045 | debian-bookworm -> localhost | changed 2026-06-12 15:55:04.228835 | 2026-06-12 15:55:04.228961 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-12 15:55:04.497238 | debian-bookworm | ok 2026-06-12 15:55:04.506297 | 2026-06-12 15:55:04.506428 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-12 15:55:05.435643 | debian-bookworm | changed: 2026-06-12 15:55:05.435939 | debian-bookworm | cd+++++++++ src/ 2026-06-12 15:55:05.435977 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-12 15:55:05.436001 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-12 15:55:05.436024 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-06-12 15:55:05.436044 | debian-bookworm | Containerfile 2026-06-12 15:55:05.436199 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/logs" 2026-06-12 15:58:23.223271 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/artifacts" 2026-06-12 15:58:23.487328 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/eb538c6e96a94706929e0db26bdf6342/work/docs" 2026-06-12 15:58:23.510873 | 2026-06-12 15:58:23.511119 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-12 15:58:24.321295 | debian-bookworm | changed: 2026-06-12 15:58:24.321715 | debian-bookworm | .d..t...... ./ 2026-06-12 15:58:24.321801 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-12 15:58:24.321864 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-12 15:58:24.321921 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-12 15:58:24.321974 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-12 15:58:24.322030 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-12 15:58:24.322189 | debian-bookworm | changed: All items complete 2026-06-12 15:58:24.322964 | 2026-06-12 15:58:24.886244 | debian-bookworm | changed: .d..t...... ./ 2026-06-12 15:58:25.454726 | debian-bookworm | changed: .d..t...... ./ 2026-06-12 15:58:25.480786 | 2026-06-12 15:58:25.480937 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-12 15:58:25.833309 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006257 2026-06-12 15:58:26.111680 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008453 2026-06-12 15:58:26.121834 | 2026-06-12 15:58:26.121940 | PLAY RECAP 2026-06-12 15:58:26.121999 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-12 15:58:26.122033 | 2026-06-12 15:58:26.261839 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-12 15:58:26.264092 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-12 15:58:26.998361 | 2026-06-12 15:58:26.998541 | PLAY [Base post] 2026-06-12 15:58:27.012049 | 2026-06-12 15:58:27.012223 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-12 15:58:27.811755 | debian-bookworm | changed 2026-06-12 15:58:27.823606 | 2026-06-12 15:58:27.823762 | PLAY RECAP 2026-06-12 15:58:27.824479 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-12 15:58:27.824594 | 2026-06-12 15:58:27.956932 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-12 15:58:27.959295 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-12 15:58:28.752223 | 2026-06-12 15:58:28.752401 | PLAY [Base post-logs] 2026-06-12 15:58:28.763331 | 2026-06-12 15:58:28.763467 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-12 15:58:29.268773 | localhost | changed 2026-06-12 15:58:29.282011 | 2026-06-12 15:58:29.282186 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-12 15:58:29.323964 | localhost | ok 2026-06-12 15:58:29.330214 | 2026-06-12 15:58:29.330374 | TASK [Set zuul-log-path fact] 2026-06-12 15:58:29.358026 | localhost | ok 2026-06-12 15:58:29.369165 | 2026-06-12 15:58:29.369302 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 15:58:29.407257 | localhost | ok 2026-06-12 15:58:29.413640 | 2026-06-12 15:58:29.413791 | TASK [upload-logs : Create log directories] 2026-06-12 15:58:29.931970 | localhost | changed 2026-06-12 15:58:29.936225 | 2026-06-12 15:58:29.936365 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-12 15:58:30.460760 | localhost -> localhost | ok: Runtime: 0:00:00.008102 2026-06-12 15:58:30.469880 | 2026-06-12 15:58:30.470112 | TASK [upload-logs : Upload logs to log server] 2026-06-12 15:58:31.040972 | localhost | Output suppressed because no_log was given 2026-06-12 15:58:31.045844 | 2026-06-12 15:58:31.046120 | LOOP [upload-logs : Compress console log and json output] 2026-06-12 15:58:31.113821 | localhost | skipping: Conditional result was False 2026-06-12 15:58:31.119500 | localhost | skipping: Conditional result was False 2026-06-12 15:58:31.130979 | 2026-06-12 15:58:31.131250 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-12 15:58:31.182775 | localhost | skipping: Conditional result was False 2026-06-12 15:58:31.183475 | 2026-06-12 15:58:31.187448 | localhost | skipping: Conditional result was False 2026-06-12 15:58:31.195432 | 2026-06-12 15:58:31.195703 | LOOP [upload-logs : Upload console log and json output]