2026-04-29 21:46:57.291117 | Job console starting 2026-04-29 21:46:57.303725 | Updating git repos 2026-04-29 21:46:57.328880 | Cloning repos into workspace 2026-04-29 21:46:57.409394 | Restoring repo states 2026-04-29 21:46:57.417593 | Merging changes 2026-04-29 21:46:58.003795 | Checking out repos 2026-04-29 21:46:58.048052 | Preparing playbooks 2026-04-29 21:46:58.667340 | Running Ansible setup 2026-04-29 21:47:02.927828 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 21:47:03.679510 | 2026-04-29 21:47:03.679674 | PLAY [Base pre] 2026-04-29 21:47:03.697035 | 2026-04-29 21:47:03.697232 | TASK [Setup log path fact] 2026-04-29 21:47:03.726099 | debian-bookworm | ok 2026-04-29 21:47:03.742960 | 2026-04-29 21:47:03.743103 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 21:47:03.792181 | debian-bookworm | ok 2026-04-29 21:47:03.802253 | 2026-04-29 21:47:03.802394 | TASK [emit-job-header : Print job information] 2026-04-29 21:47:03.859657 | # Job Information 2026-04-29 21:47:03.859967 | Ansible Version: 2.16.14 2026-04-29 21:47:03.860041 | Job: ansible-lint 2026-04-29 21:47:03.860110 | Pipeline: check 2026-04-29 21:47:03.860161 | Executor: 521e9411259a 2026-04-29 21:47:03.860205 | Triggered by: https://github.com/osism/metalbox/pull/354 2026-04-29 21:47:03.860252 | Event ID: eca2c140-4414-11f1-8df9-42a222fced83 2026-04-29 21:47:03.868648 | 2026-04-29 21:47:03.868810 | LOOP [emit-job-header : Print node information] 2026-04-29 21:47:03.988295 | debian-bookworm | ok: 2026-04-29 21:47:03.989016 | debian-bookworm | # Node Information 2026-04-29 21:47:03.989097 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-29 21:47:03.989124 | debian-bookworm | Hostname: debian 2026-04-29 21:47:03.989148 | debian-bookworm | Username: zuul 2026-04-29 21:47:03.989169 | debian-bookworm | Distro: Debian 12.13 2026-04-29 21:47:03.989200 | debian-bookworm | Provider: regiocloud-a 2026-04-29 21:47:03.989227 | debian-bookworm | Region: 2026-04-29 21:47:03.989248 | debian-bookworm | Label: debian-bookworm 2026-04-29 21:47:03.989267 | debian-bookworm | Product Name: OpenStack Nova 2026-04-29 21:47:03.989286 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:ffe8 2026-04-29 21:47:04.008899 | 2026-04-29 21:47:04.009034 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 21:47:04.507387 | debian-bookworm -> localhost | changed 2026-04-29 21:47:04.515868 | 2026-04-29 21:47:04.515996 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 21:47:05.551518 | debian-bookworm -> localhost | changed 2026-04-29 21:47:05.563520 | 2026-04-29 21:47:05.563646 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 21:47:05.840923 | debian-bookworm -> localhost | ok 2026-04-29 21:47:05.854676 | 2026-04-29 21:47:05.854887 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 21:47:05.891408 | debian-bookworm | ok 2026-04-29 21:47:05.906686 | debian-bookworm | included: /var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 21:47:05.913805 | 2026-04-29 21:47:05.913910 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 21:47:07.223780 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-29 21:47:07.224014 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/92732f5a67d54283909a053edb3d48e0_id_rsa 2026-04-29 21:47:07.224054 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/92732f5a67d54283909a053edb3d48e0_id_rsa.pub 2026-04-29 21:47:07.224082 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-29 21:47:07.224107 | debian-bookworm -> localhost | SHA256:FnvEExL3mo3xylXxF71B3JUMTzga8PCWnJGEoXUe+e4 zuul-build-sshkey 2026-04-29 21:47:07.224130 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-29 21:47:07.224165 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-29 21:47:07.224189 | debian-bookworm -> localhost | | o*B=o.B+*| 2026-04-29 21:47:07.224212 | debian-bookworm -> localhost | | o=B*=ooB+| 2026-04-29 21:47:07.224232 | debian-bookworm -> localhost | | .. =O= o.=| 2026-04-29 21:47:07.224252 | debian-bookworm -> localhost | | +.X o ..| 2026-04-29 21:47:07.224271 | debian-bookworm -> localhost | | S = = | 2026-04-29 21:47:07.224298 | debian-bookworm -> localhost | | . o o . | 2026-04-29 21:47:07.224318 | debian-bookworm -> localhost | | o . | 2026-04-29 21:47:07.224356 | debian-bookworm -> localhost | | E | 2026-04-29 21:47:07.224378 | debian-bookworm -> localhost | | | 2026-04-29 21:47:07.224399 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-29 21:47:07.224457 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.795026 2026-04-29 21:47:07.231023 | 2026-04-29 21:47:07.231135 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 21:47:07.259401 | debian-bookworm | ok 2026-04-29 21:47:07.268715 | debian-bookworm | included: /var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 21:47:07.278048 | 2026-04-29 21:47:07.278158 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 21:47:07.301935 | debian-bookworm | skipping: Conditional result was False 2026-04-29 21:47:07.307911 | 2026-04-29 21:47:07.308019 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 21:47:07.958456 | debian-bookworm | changed 2026-04-29 21:47:07.966603 | 2026-04-29 21:47:07.966722 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 21:47:08.217729 | debian-bookworm | ok 2026-04-29 21:47:08.226139 | 2026-04-29 21:47:08.226285 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 21:47:08.861294 | debian-bookworm | changed 2026-04-29 21:47:08.875504 | 2026-04-29 21:47:08.875680 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 21:47:09.557486 | debian-bookworm | changed 2026-04-29 21:47:09.563189 | 2026-04-29 21:47:09.563301 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 21:47:09.587229 | debian-bookworm | skipping: Conditional result was False 2026-04-29 21:47:09.593205 | 2026-04-29 21:47:09.593312 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 21:47:10.057972 | debian-bookworm -> localhost | changed 2026-04-29 21:47:10.069139 | 2026-04-29 21:47:10.069265 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 21:47:10.407421 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/92732f5a67d54283909a053edb3d48e0_id_rsa (zuul-build-sshkey) 2026-04-29 21:47:10.407752 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018878 2026-04-29 21:47:10.416312 | 2026-04-29 21:47:10.416482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 21:47:10.826871 | debian-bookworm | ok 2026-04-29 21:47:10.835260 | 2026-04-29 21:47:10.835456 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 21:47:10.862043 | debian-bookworm | skipping: Conditional result was False 2026-04-29 21:47:10.881989 | 2026-04-29 21:47:10.882133 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-29 21:47:11.311338 | debian-bookworm | ok 2026-04-29 21:47:11.326991 | 2026-04-29 21:47:11.327126 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-29 21:47:11.367467 | debian-bookworm | ok 2026-04-29 21:47:11.373760 | 2026-04-29 21:47:11.373884 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-29 21:47:11.692362 | debian-bookworm -> localhost | ok 2026-04-29 21:47:11.701745 | 2026-04-29 21:47:11.701887 | TASK [validate-host : Collect information about the host] 2026-04-29 21:47:12.838896 | debian-bookworm | ok 2026-04-29 21:47:12.850894 | 2026-04-29 21:47:12.851020 | TASK [validate-host : Sanitize hostname] 2026-04-29 21:47:12.958987 | debian-bookworm | ok 2026-04-29 21:47:12.999944 | 2026-04-29 21:47:13.000072 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-29 21:47:13.620396 | debian-bookworm -> localhost | changed 2026-04-29 21:47:13.632716 | 2026-04-29 21:47:13.632897 | TASK [validate-host : Collect information about zuul worker] 2026-04-29 21:47:14.047146 | debian-bookworm | ok 2026-04-29 21:47:14.051887 | 2026-04-29 21:47:14.051996 | TASK [validate-host : Write out all zuul information for each host] 2026-04-29 21:47:14.594246 | debian-bookworm -> localhost | changed 2026-04-29 21:47:14.605589 | 2026-04-29 21:47:14.605705 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-29 21:47:14.914012 | debian-bookworm | ok 2026-04-29 21:47:14.926102 | 2026-04-29 21:47:14.926254 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-29 21:47:15.969654 | debian-bookworm | changed: 2026-04-29 21:47:15.969887 | debian-bookworm | cd+++++++++ src/ 2026-04-29 21:47:15.969928 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-29 21:47:15.969956 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-29 21:47:15.970031 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2026-04-29 21:47:15.970062 | debian-bookworm | Containerfile 2026-04-29 21:47:15.987226 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/logs" 2026-04-29 21:48:09.520740 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/artifacts" 2026-04-29 21:48:09.783160 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/92732f5a67d54283909a053edb3d48e0/work/docs" 2026-04-29 21:48:09.807392 | 2026-04-29 21:48:09.807531 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 21:48:10.572885 | debian-bookworm | changed: 2026-04-29 21:48:10.573186 | debian-bookworm | .d..t...... ./ 2026-04-29 21:48:10.573238 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-29 21:48:10.573309 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-29 21:48:10.573355 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-29 21:48:10.573413 | debian-bookworm | changed: All items complete 2026-04-29 21:48:10.573451 | 2026-04-29 21:48:11.145192 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 21:48:11.714526 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 21:48:11.744552 | 2026-04-29 21:48:11.744699 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 21:48:12.264387 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.013206 2026-04-29 21:48:12.527117 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010502 2026-04-29 21:48:12.541287 | 2026-04-29 21:48:12.541425 | PLAY RECAP 2026-04-29 21:48:12.541508 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-29 21:48:12.541549 | 2026-04-29 21:48:12.671006 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-29 21:48:12.673317 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 21:48:13.433058 | 2026-04-29 21:48:13.433234 | PLAY [Base post] 2026-04-29 21:48:13.447659 | 2026-04-29 21:48:13.447814 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 21:48:14.023150 | debian-bookworm | changed 2026-04-29 21:48:14.033113 | 2026-04-29 21:48:14.033298 | PLAY RECAP 2026-04-29 21:48:14.033387 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 21:48:14.033480 | 2026-04-29 21:48:14.157423 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 21:48:14.159525 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 21:48:14.971024 | 2026-04-29 21:48:14.971209 | PLAY [Base post-logs] 2026-04-29 21:48:14.982567 | 2026-04-29 21:48:14.982718 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 21:48:15.466539 | localhost | changed 2026-04-29 21:48:15.476897 | 2026-04-29 21:48:15.477057 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 21:48:15.502480 | localhost | ok 2026-04-29 21:48:15.505546 | 2026-04-29 21:48:15.505642 | TASK [Set zuul-log-path fact] 2026-04-29 21:48:15.523228 | localhost | ok 2026-04-29 21:48:15.540739 | 2026-04-29 21:48:15.540912 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 21:48:15.580817 | localhost | ok 2026-04-29 21:48:15.587226 | 2026-04-29 21:48:15.587404 | TASK [upload-logs : Create log directories] 2026-04-29 21:48:16.123916 | localhost | changed 2026-04-29 21:48:16.128907 | 2026-04-29 21:48:16.129064 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 21:48:16.626787 | localhost -> localhost | ok: Runtime: 0:00:00.005357 2026-04-29 21:48:16.637711 | 2026-04-29 21:48:16.637936 | TASK [upload-logs : Upload logs to log server] 2026-04-29 21:48:17.194147 | localhost | Output suppressed because no_log was given 2026-04-29 21:48:17.196201 | 2026-04-29 21:48:17.196356 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 21:48:17.259685 | localhost | skipping: Conditional result was False 2026-04-29 21:48:17.266323 | localhost | skipping: Conditional result was False 2026-04-29 21:48:17.277217 | 2026-04-29 21:48:17.277412 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 21:48:17.323603 | localhost | skipping: Conditional result was False 2026-04-29 21:48:17.323921 | 2026-04-29 21:48:17.328497 | localhost | skipping: Conditional result was False 2026-04-29 21:48:17.337657 | 2026-04-29 21:48:17.337878 | LOOP [upload-logs : Upload console log and json output]