2026-05-03 13:11:09.428818 | Job console starting 2026-05-03 13:11:09.442685 | Updating git repos 2026-05-03 13:11:09.470666 | Cloning repos into workspace 2026-05-03 13:11:09.559900 | Restoring repo states 2026-05-03 13:11:09.569885 | Merging changes 2026-05-03 13:11:09.569942 | Checking out repos 2026-05-03 13:11:09.659199 | Preparing playbooks 2026-05-03 13:11:10.392004 | Running Ansible setup 2026-05-03 13:11:14.652972 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-03 13:11:15.403800 | 2026-05-03 13:11:15.403992 | PLAY [Base pre] 2026-05-03 13:11:15.422675 | 2026-05-03 13:11:15.422866 | TASK [Setup log path fact] 2026-05-03 13:11:15.460975 | debian-bookworm | ok 2026-05-03 13:11:15.493786 | 2026-05-03 13:11:15.493994 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 13:11:15.539382 | debian-bookworm | ok 2026-05-03 13:11:15.554259 | 2026-05-03 13:11:15.554435 | TASK [emit-job-header : Print job information] 2026-05-03 13:11:15.600379 | # Job Information 2026-05-03 13:11:15.600664 | Ansible Version: 2.16.14 2026-05-03 13:11:15.600724 | Job: container-image-inventory-reconciler-push 2026-05-03 13:11:15.600781 | Pipeline: post 2026-05-03 13:11:15.600823 | Executor: 521e9411259a 2026-05-03 13:11:15.600861 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/commit/bb9ef62f7844b62b29178fcf4c3896a2b20696d8 2026-05-03 13:11:15.600901 | Event ID: 8968f27c-46f1-11f1-94b4-17665bf167fa 2026-05-03 13:11:15.608623 | 2026-05-03 13:11:15.608792 | LOOP [emit-job-header : Print node information] 2026-05-03 13:11:15.721100 | debian-bookworm | ok: 2026-05-03 13:11:15.721420 | debian-bookworm | # Node Information 2026-05-03 13:11:15.721484 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-03 13:11:15.721527 | debian-bookworm | Hostname: debian 2026-05-03 13:11:15.721564 | debian-bookworm | Username: zuul 2026-05-03 13:11:15.721600 | debian-bookworm | Distro: Debian 12.13 2026-05-03 13:11:15.721643 | debian-bookworm | Provider: regiocloud-a 2026-05-03 13:11:15.721681 | debian-bookworm | Region: 2026-05-03 13:11:15.721718 | debian-bookworm | Label: debian-bookworm 2026-05-03 13:11:15.721753 | debian-bookworm | Product Name: OpenStack Nova 2026-05-03 13:11:15.721788 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe71:ec98 2026-05-03 13:11:15.749539 | 2026-05-03 13:11:15.749719 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-03 13:11:16.252916 | debian-bookworm -> localhost | changed 2026-05-03 13:11:16.260681 | 2026-05-03 13:11:16.260823 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-03 13:11:17.323070 | debian-bookworm -> localhost | changed 2026-05-03 13:11:17.334647 | 2026-05-03 13:11:17.334788 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-03 13:11:17.633314 | debian-bookworm -> localhost | ok 2026-05-03 13:11:17.644046 | 2026-05-03 13:11:17.644215 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-03 13:11:17.681893 | debian-bookworm | ok 2026-05-03 13:11:17.699093 | debian-bookworm | included: /var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-03 13:11:17.706023 | 2026-05-03 13:11:17.706152 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-03 13:11:18.657489 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-03 13:11:18.657749 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/6234d42902274f5ea7d199c5bd1d2e59_id_rsa 2026-05-03 13:11:18.657789 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/6234d42902274f5ea7d199c5bd1d2e59_id_rsa.pub 2026-05-03 13:11:18.657816 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-03 13:11:18.657841 | debian-bookworm -> localhost | SHA256:8GLaL/omGXFOBgHE9MSS1FlPFYdCkeVypuW/N3djYeE zuul-build-sshkey 2026-05-03 13:11:18.657880 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-03 13:11:18.657903 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-03 13:11:18.657925 | debian-bookworm -> localhost | | ===o+..+=+o. | 2026-05-03 13:11:18.657948 | debian-bookworm -> localhost | | +o= oo... | 2026-05-03 13:11:18.657969 | debian-bookworm -> localhost | | .... o.= | 2026-05-03 13:11:18.657989 | debian-bookworm -> localhost | | . +o B . | 2026-05-03 13:11:18.658010 | debian-bookworm -> localhost | | *o S . . .| 2026-05-03 13:11:18.658036 | debian-bookworm -> localhost | | .+.. . E | 2026-05-03 13:11:18.658057 | debian-bookworm -> localhost | | .o. . . .| 2026-05-03 13:11:18.658077 | debian-bookworm -> localhost | | o o. .ooo| 2026-05-03 13:11:18.658098 | debian-bookworm -> localhost | | .=... ...oo| 2026-05-03 13:11:18.658118 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-03 13:11:18.658176 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.456145 2026-05-03 13:11:18.665289 | 2026-05-03 13:11:18.665467 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-03 13:11:18.694583 | debian-bookworm | ok 2026-05-03 13:11:18.704161 | debian-bookworm | included: /var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-03 13:11:18.713456 | 2026-05-03 13:11:18.713569 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-03 13:11:18.737827 | debian-bookworm | skipping: Conditional result was False 2026-05-03 13:11:18.743975 | 2026-05-03 13:11:18.744093 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-03 13:11:19.390220 | debian-bookworm | changed 2026-05-03 13:11:19.398502 | 2026-05-03 13:11:19.398639 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-03 13:11:19.669121 | debian-bookworm | ok 2026-05-03 13:11:19.679898 | 2026-05-03 13:11:19.680086 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-03 13:11:20.339542 | debian-bookworm | changed 2026-05-03 13:11:20.349817 | 2026-05-03 13:11:20.350026 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-03 13:11:20.988466 | debian-bookworm | changed 2026-05-03 13:11:20.997662 | 2026-05-03 13:11:20.997814 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-03 13:11:21.024920 | debian-bookworm | skipping: Conditional result was False 2026-05-03 13:11:21.039463 | 2026-05-03 13:11:21.039669 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-03 13:11:21.534774 | debian-bookworm -> localhost | changed 2026-05-03 13:11:21.551699 | 2026-05-03 13:11:21.551839 | TASK [add-build-sshkey : Add back temp key] 2026-05-03 13:11:21.889936 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/6234d42902274f5ea7d199c5bd1d2e59_id_rsa (zuul-build-sshkey) 2026-05-03 13:11:21.890230 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018408 2026-05-03 13:11:21.898663 | 2026-05-03 13:11:21.898799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-03 13:11:22.290326 | debian-bookworm | ok 2026-05-03 13:11:22.296626 | 2026-05-03 13:11:22.296773 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-03 13:11:22.331035 | debian-bookworm | skipping: Conditional result was False 2026-05-03 13:11:22.349274 | 2026-05-03 13:11:22.349516 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-03 13:11:22.805106 | debian-bookworm | ok 2026-05-03 13:11:22.820489 | 2026-05-03 13:11:22.820636 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-03 13:11:22.863659 | debian-bookworm | ok 2026-05-03 13:11:22.870671 | 2026-05-03 13:11:22.870796 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-03 13:11:23.169311 | debian-bookworm -> localhost | ok 2026-05-03 13:11:23.185431 | 2026-05-03 13:11:23.185632 | TASK [validate-host : Collect information about the host] 2026-05-03 13:11:24.282765 | debian-bookworm | ok 2026-05-03 13:11:24.296533 | 2026-05-03 13:11:24.296689 | TASK [validate-host : Sanitize hostname] 2026-05-03 13:11:24.415887 | debian-bookworm | ok 2026-05-03 13:11:24.460435 | 2026-05-03 13:11:24.460578 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-03 13:11:25.065775 | debian-bookworm -> localhost | changed 2026-05-03 13:11:25.079142 | 2026-05-03 13:11:25.079305 | TASK [validate-host : Collect information about zuul worker] 2026-05-03 13:11:25.489920 | debian-bookworm | ok 2026-05-03 13:11:25.502176 | 2026-05-03 13:11:25.502543 | TASK [validate-host : Write out all zuul information for each host] 2026-05-03 13:11:26.108329 | debian-bookworm -> localhost | changed 2026-05-03 13:11:26.128049 | 2026-05-03 13:11:26.128223 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-03 13:11:26.405971 | debian-bookworm | ok 2026-05-03 13:11:26.414970 | 2026-05-03 13:11:26.415114 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-03 13:11:27.383727 | debian-bookworm | changed: 2026-05-03 13:11:27.384005 | debian-bookworm | cd+++++++++ src/ 2026-05-03 13:11:27.384056 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-03 13:11:27.384091 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-03 13:11:27.384122 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-05-03 13:11:27.384151 | debian-bookworm | Containerfile 2026-05-03 13:11:27.384417 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/logs" 2026-05-03 13:14:16.037037 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/artifacts" 2026-05-03 13:14:16.942369 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6234d42902274f5ea7d199c5bd1d2e59/work/docs" 2026-05-03 13:14:16.957476 | 2026-05-03 13:14:16.957579 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-03 13:14:18.653320 | debian-bookworm | changed: 2026-05-03 13:14:18.653516 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-03 13:14:18.653550 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-03 13:14:18.653577 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-03 13:14:18.653617 | debian-bookworm | changed: All items complete 2026-05-03 13:14:18.653640 | 2026-05-03 13:14:19.871050 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 13:14:21.024055 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 13:14:21.046778 | 2026-05-03 13:14:21.046893 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-03 13:14:21.098360 | debian-bookworm | skipping: Conditional result was False 2026-05-03 13:14:21.104034 | debian-bookworm | skipping: Conditional result was False 2026-05-03 13:14:21.118954 | 2026-05-03 13:14:21.119197 | PLAY RECAP 2026-05-03 13:14:21.119256 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-03 13:14:21.119278 | 2026-05-03 13:14:21.387992 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-03 13:14:21.390009 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 13:14:24.065966 | 2026-05-03 13:14:24.066129 | PLAY [Base post] 2026-05-03 13:14:24.092062 | 2026-05-03 13:14:24.094997 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-03 13:14:25.138035 | debian-bookworm | changed 2026-05-03 13:14:25.151412 | 2026-05-03 13:14:25.151530 | PLAY RECAP 2026-05-03 13:14:25.151585 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-03 13:14:25.151637 | 2026-05-03 13:14:25.643117 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 13:14:25.643865 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-03 13:14:27.811617 | 2026-05-03 13:14:27.811751 | PLAY [Base post-logs] 2026-05-03 13:14:27.837371 | 2026-05-03 13:14:27.837512 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-03 13:14:29.476785 | localhost | changed 2026-05-03 13:14:29.484587 | 2026-05-03 13:14:29.484709 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-03 13:14:29.591593 | localhost | ok 2026-05-03 13:14:29.594364 | 2026-05-03 13:14:29.594480 | TASK [Set zuul-log-path fact] 2026-05-03 13:14:29.673667 | localhost | ok 2026-05-03 13:14:29.688404 | 2026-05-03 13:14:29.688525 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 13:14:29.761989 | localhost | ok 2026-05-03 13:14:29.764766 | 2026-05-03 13:14:29.764863 | TASK [upload-logs : Create log directories] 2026-05-03 13:14:31.426083 | localhost | changed 2026-05-03 13:14:31.428268 | 2026-05-03 13:14:31.428343 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-03 13:14:33.154972 | localhost -> localhost | ok: Runtime: 0:00:00.054737 2026-05-03 13:14:33.158205 | 2026-05-03 13:14:33.158294 | TASK [upload-logs : Upload logs to log server] 2026-05-03 13:14:34.643836 | localhost | Output suppressed because no_log was given 2026-05-03 13:14:34.645284 | 2026-05-03 13:14:34.645363 | LOOP [upload-logs : Compress console log and json output] 2026-05-03 13:14:34.766222 | localhost | skipping: Conditional result was False 2026-05-03 13:14:34.784890 | localhost | skipping: Conditional result was False 2026-05-03 13:14:34.796246 | 2026-05-03 13:14:34.796335 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-03 13:14:34.891009 | localhost | skipping: Conditional result was False 2026-05-03 13:14:34.891230 | 2026-05-03 13:14:34.908041 | localhost | skipping: Conditional result was False 2026-05-03 13:14:34.911766 | 2026-05-03 13:14:34.911869 | LOOP [upload-logs : Upload console log and json output]