2026-05-24 03:11:14.633940 | Job console starting 2026-05-24 03:11:14.640614 | Updating git repos 2026-05-24 03:11:14.682808 | Cloning repos into workspace 2026-05-24 03:11:14.710710 | Restoring repo states 2026-05-24 03:11:14.736704 | Merging changes 2026-05-24 03:11:14.736718 | Checking out repos 2026-05-24 03:11:14.788536 | Preparing playbooks 2026-05-24 03:11:16.352253 | Running Ansible setup 2026-05-24 03:11:21.785283 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-24 03:11:22.830011 | 2026-05-24 03:11:22.830148 | PLAY [Base pre] 2026-05-24 03:11:22.907415 | 2026-05-24 03:11:22.907571 | TASK [Setup log path fact] 2026-05-24 03:11:22.958237 | debian-bookworm | ok 2026-05-24 03:11:23.016350 | 2026-05-24 03:11:23.016495 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 03:11:23.085382 | debian-bookworm | ok 2026-05-24 03:11:23.094265 | 2026-05-24 03:11:23.094362 | TASK [emit-job-header : Print job information] 2026-05-24 03:11:23.179001 | # Job Information 2026-05-24 03:11:23.179141 | Ansible Version: 2.16.14 2026-05-24 03:11:23.179171 | Job: hadolint 2026-05-24 03:11:23.179200 | Pipeline: periodic-daily 2026-05-24 03:11:23.179220 | Executor: 521e9411259a 2026-05-24 03:11:23.179237 | Triggered by: https://github.com/osism/node-image 2026-05-24 03:11:23.179256 | Event ID: a3fc4669e2664279b7b2f078e9e1f7a4 2026-05-24 03:11:23.183827 | 2026-05-24 03:11:23.183902 | LOOP [emit-job-header : Print node information] 2026-05-24 03:11:23.456189 | debian-bookworm | ok: 2026-05-24 03:11:23.456379 | debian-bookworm | # Node Information 2026-05-24 03:11:23.456409 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-24 03:11:23.456429 | debian-bookworm | Hostname: debian 2026-05-24 03:11:23.456456 | debian-bookworm | Username: zuul 2026-05-24 03:11:23.456473 | debian-bookworm | Distro: Debian 12.14 2026-05-24 03:11:23.456581 | debian-bookworm | Provider: regiocloud-a 2026-05-24 03:11:23.456608 | debian-bookworm | Region: 2026-05-24 03:11:23.456626 | debian-bookworm | Label: debian-bookworm 2026-05-24 03:11:23.456644 | debian-bookworm | Product Name: OpenStack Nova 2026-05-24 03:11:23.456661 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feda:763f 2026-05-24 03:11:23.473680 | 2026-05-24 03:11:23.473781 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-24 03:11:24.454756 | debian-bookworm -> localhost | changed 2026-05-24 03:11:24.465771 | 2026-05-24 03:11:24.465876 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-24 03:11:26.358698 | debian-bookworm -> localhost | changed 2026-05-24 03:11:26.369327 | 2026-05-24 03:11:26.369420 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-24 03:11:26.632083 | debian-bookworm -> localhost | ok 2026-05-24 03:11:26.637904 | 2026-05-24 03:11:26.637996 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-24 03:11:26.667815 | debian-bookworm | ok 2026-05-24 03:11:26.683191 | debian-bookworm | included: /var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-24 03:11:26.689186 | 2026-05-24 03:11:26.689341 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-24 03:11:28.470203 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-24 03:11:28.470397 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/5ccd57d9fe964bc3bf3a9d56d1302c35_id_rsa 2026-05-24 03:11:28.470429 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/5ccd57d9fe964bc3bf3a9d56d1302c35_id_rsa.pub 2026-05-24 03:11:28.470462 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-24 03:11:28.470482 | debian-bookworm -> localhost | SHA256:Dr7vaTDt0IdwbXDsvSSnc0KRzjm2Hwx8V85eMlolV1U zuul-build-sshkey 2026-05-24 03:11:28.470501 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-24 03:11:28.470526 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-24 03:11:28.470545 | debian-bookworm -> localhost | | . . E| 2026-05-24 03:11:28.470563 | debian-bookworm -> localhost | | . = . +| 2026-05-24 03:11:28.470581 | debian-bookworm -> localhost | | O + B | 2026-05-24 03:11:28.470598 | debian-bookworm -> localhost | | . . # = = +| 2026-05-24 03:11:28.470614 | debian-bookworm -> localhost | | .=S= @ = +.| 2026-05-24 03:11:28.470633 | debian-bookworm -> localhost | | .+o+ * * .| 2026-05-24 03:11:28.470651 | debian-bookworm -> localhost | | .=.. = . | 2026-05-24 03:11:28.470668 | debian-bookworm -> localhost | | .o. . | 2026-05-24 03:11:28.470685 | debian-bookworm -> localhost | | .++ | 2026-05-24 03:11:28.470701 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-24 03:11:28.470754 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.262345 2026-05-24 03:11:28.484727 | 2026-05-24 03:11:28.484815 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-24 03:11:28.538218 | debian-bookworm | ok 2026-05-24 03:11:28.566390 | debian-bookworm | included: /var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-24 03:11:28.598972 | 2026-05-24 03:11:28.599080 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-24 03:11:28.646895 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:11:28.658237 | 2026-05-24 03:11:28.658333 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-24 03:11:29.372385 | debian-bookworm | changed 2026-05-24 03:11:29.381502 | 2026-05-24 03:11:29.381605 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-24 03:11:29.670951 | debian-bookworm | ok 2026-05-24 03:11:29.681735 | 2026-05-24 03:11:29.681824 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-24 03:11:30.402852 | debian-bookworm | changed 2026-05-24 03:11:30.410129 | 2026-05-24 03:11:30.410233 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-24 03:11:31.102018 | debian-bookworm | changed 2026-05-24 03:11:31.107472 | 2026-05-24 03:11:31.107566 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-24 03:11:31.120602 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:11:31.127431 | 2026-05-24 03:11:31.127558 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-24 03:11:31.775463 | debian-bookworm -> localhost | changed 2026-05-24 03:11:31.788387 | 2026-05-24 03:11:31.788503 | TASK [add-build-sshkey : Add back temp key] 2026-05-24 03:11:32.581719 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/5ccd57d9fe964bc3bf3a9d56d1302c35_id_rsa (zuul-build-sshkey) 2026-05-24 03:11:32.581933 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019772 2026-05-24 03:11:32.590462 | 2026-05-24 03:11:32.590562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-24 03:11:33.120188 | debian-bookworm | ok 2026-05-24 03:11:33.132482 | 2026-05-24 03:11:33.132624 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-24 03:11:33.191790 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:11:33.210062 | 2026-05-24 03:11:33.210292 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-24 03:11:33.999472 | debian-bookworm | ok 2026-05-24 03:11:34.013934 | 2026-05-24 03:11:34.014031 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-24 03:11:34.073807 | debian-bookworm | ok 2026-05-24 03:11:34.078325 | 2026-05-24 03:11:34.078400 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-24 03:11:34.683869 | debian-bookworm -> localhost | ok 2026-05-24 03:11:34.689157 | 2026-05-24 03:11:34.689231 | TASK [validate-host : Collect information about the host] 2026-05-24 03:11:36.091349 | debian-bookworm | ok 2026-05-24 03:11:36.102449 | 2026-05-24 03:11:36.102590 | TASK [validate-host : Sanitize hostname] 2026-05-24 03:11:36.203674 | debian-bookworm | ok 2026-05-24 03:11:36.233227 | 2026-05-24 03:11:36.233325 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-24 03:11:36.948992 | debian-bookworm -> localhost | changed 2026-05-24 03:11:36.956099 | 2026-05-24 03:11:36.956207 | TASK [validate-host : Collect information about zuul worker] 2026-05-24 03:11:37.496231 | debian-bookworm | ok 2026-05-24 03:11:37.500990 | 2026-05-24 03:11:37.501090 | TASK [validate-host : Write out all zuul information for each host] 2026-05-24 03:11:38.787838 | debian-bookworm -> localhost | changed 2026-05-24 03:11:38.801170 | 2026-05-24 03:11:38.801275 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-24 03:11:39.092678 | debian-bookworm | ok 2026-05-24 03:11:39.098716 | 2026-05-24 03:11:39.098808 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-24 03:11:40.906934 | debian-bookworm | changed: 2026-05-24 03:11:40.907102 | debian-bookworm | cd+++++++++ src/ 2026-05-24 03:11:40.907134 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-24 03:11:40.907157 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-24 03:11:40.907178 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2026-05-24 03:11:40.907197 | debian-bookworm | Containerfile 2026-05-24 03:11:40.907325 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/logs" 2026-05-24 03:11:52.383590 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/artifacts" 2026-05-24 03:11:53.267909 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5ccd57d9fe964bc3bf3a9d56d1302c35/work/docs" 2026-05-24 03:11:53.279723 | 2026-05-24 03:11:53.279818 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-24 03:11:55.099795 | debian-bookworm | changed: 2026-05-24 03:11:55.100041 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-24 03:11:55.100080 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-24 03:11:55.100109 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-24 03:11:55.100154 | debian-bookworm | changed: All items complete 2026-05-24 03:11:55.100180 | 2026-05-24 03:11:56.648545 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 03:11:57.929045 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 03:11:57.963843 | 2026-05-24 03:11:57.964105 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-24 03:11:58.057181 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:11:58.071674 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:11:58.090625 | 2026-05-24 03:11:58.090769 | PLAY RECAP 2026-05-24 03:11:58.090816 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-24 03:11:58.090864 | 2026-05-24 03:11:58.488301 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-24 03:11:58.488936 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 03:12:00.640825 | 2026-05-24 03:12:00.640955 | PLAY [Base post] 2026-05-24 03:12:00.691913 | 2026-05-24 03:12:00.692024 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-24 03:12:01.636159 | debian-bookworm | changed 2026-05-24 03:12:01.644077 | 2026-05-24 03:12:01.644176 | PLAY RECAP 2026-05-24 03:12:01.644235 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-24 03:12:01.644298 | 2026-05-24 03:12:02.296024 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 03:12:02.296713 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-24 03:12:04.893680 | 2026-05-24 03:12:04.893831 | PLAY [Base post-logs] 2026-05-24 03:12:04.945372 | 2026-05-24 03:12:04.945526 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-24 03:12:05.806555 | localhost | changed 2026-05-24 03:12:05.815733 | 2026-05-24 03:12:05.815866 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-24 03:12:05.857558 | localhost | ok 2026-05-24 03:12:05.859988 | 2026-05-24 03:12:05.860063 | TASK [Set zuul-log-path fact] 2026-05-24 03:12:05.884176 | localhost | ok 2026-05-24 03:12:05.898413 | 2026-05-24 03:12:05.898513 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 03:12:05.936650 | localhost | ok 2026-05-24 03:12:05.939235 | 2026-05-24 03:12:05.939316 | TASK [upload-logs : Create log directories] 2026-05-24 03:12:06.899796 | localhost | changed 2026-05-24 03:12:06.901911 | 2026-05-24 03:12:06.901988 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-24 03:12:08.057285 | localhost -> localhost | ok: Runtime: 0:00:00.019344 2026-05-24 03:12:08.061237 | 2026-05-24 03:12:08.061325 | TASK [upload-logs : Upload logs to log server] 2026-05-24 03:12:09.247270 | localhost | Output suppressed because no_log was given 2026-05-24 03:12:09.248629 | 2026-05-24 03:12:09.248698 | LOOP [upload-logs : Compress console log and json output] 2026-05-24 03:12:09.327958 | localhost | skipping: Conditional result was False 2026-05-24 03:12:09.335029 | localhost | skipping: Conditional result was False 2026-05-24 03:12:09.341183 | 2026-05-24 03:12:09.341272 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-24 03:12:09.481301 | localhost | skipping: Conditional result was False 2026-05-24 03:12:09.481591 | 2026-05-24 03:12:09.486006 | localhost | skipping: Conditional result was False 2026-05-24 03:12:09.488512 | 2026-05-24 03:12:09.488598 | LOOP [upload-logs : Upload console log and json output]