2026-05-15 16:38:34.080539 | Job console starting 2026-05-15 16:38:34.108111 | Updating git repos 2026-05-15 16:38:34.202034 | Cloning repos into workspace 2026-05-15 16:38:34.301204 | Restoring repo states 2026-05-15 16:38:34.313445 | Merging changes 2026-05-15 16:38:35.092681 | Checking out repos 2026-05-15 16:38:35.227585 | Preparing playbooks 2026-05-15 16:38:36.885704 | Running Ansible setup 2026-05-15 16:38:42.836893 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-15 16:38:43.708323 | 2026-05-15 16:38:43.708445 | PLAY [Base pre] 2026-05-15 16:38:43.742281 | 2026-05-15 16:38:43.742394 | TASK [Setup log path fact] 2026-05-15 16:38:43.781416 | debian-bookworm | ok 2026-05-15 16:38:43.821937 | 2026-05-15 16:38:43.822060 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 16:38:43.897336 | debian-bookworm | ok 2026-05-15 16:38:43.913301 | 2026-05-15 16:38:43.913406 | TASK [emit-job-header : Print job information] 2026-05-15 16:38:43.971239 | # Job Information 2026-05-15 16:38:43.971386 | Ansible Version: 2.16.14 2026-05-15 16:38:43.971416 | Job: hadolint 2026-05-15 16:38:43.971443 | Pipeline: check 2026-05-15 16:38:43.971462 | Executor: 521e9411259a 2026-05-15 16:38:43.971480 | Triggered by: https://github.com/osism/python-osism/pull/2274 2026-05-15 16:38:43.971498 | Event ID: 7d61e350-507c-11f1-8c47-5353fc91f69c 2026-05-15 16:38:43.975507 | 2026-05-15 16:38:43.975585 | LOOP [emit-job-header : Print node information] 2026-05-15 16:38:44.063730 | debian-bookworm | ok: 2026-05-15 16:38:44.063873 | debian-bookworm | # Node Information 2026-05-15 16:38:44.063901 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-15 16:38:44.063922 | debian-bookworm | Hostname: debian 2026-05-15 16:38:44.063941 | debian-bookworm | Username: zuul 2026-05-15 16:38:44.063958 | debian-bookworm | Distro: Debian 12.13 2026-05-15 16:38:44.063978 | debian-bookworm | Provider: regiocloud-a 2026-05-15 16:38:44.063995 | debian-bookworm | Region: 2026-05-15 16:38:44.064011 | debian-bookworm | Label: debian-bookworm 2026-05-15 16:38:44.064028 | debian-bookworm | Product Name: OpenStack Nova 2026-05-15 16:38:44.064044 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9f:f1fa 2026-05-15 16:38:44.073425 | 2026-05-15 16:38:44.073517 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-15 16:38:44.725517 | debian-bookworm -> localhost | changed 2026-05-15 16:38:44.731773 | 2026-05-15 16:38:44.731861 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-15 16:38:46.469786 | debian-bookworm -> localhost | changed 2026-05-15 16:38:46.478427 | 2026-05-15 16:38:46.478518 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-15 16:38:47.056489 | debian-bookworm -> localhost | ok 2026-05-15 16:38:47.061578 | 2026-05-15 16:38:47.061671 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-15 16:38:47.101284 | debian-bookworm | ok 2026-05-15 16:38:47.123961 | debian-bookworm | included: /var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-15 16:38:47.128823 | 2026-05-15 16:38:47.128894 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-15 16:38:49.912561 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-15 16:38:49.912732 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/b7987cd66aa24a7ebc902a6daf846bfe_id_rsa 2026-05-15 16:38:49.912762 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/b7987cd66aa24a7ebc902a6daf846bfe_id_rsa.pub 2026-05-15 16:38:49.912784 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-15 16:38:49.912804 | debian-bookworm -> localhost | SHA256:tRMGkN+mR9vQbV+jUgVAa202fbFCzXI5lRBtqolr2c0 zuul-build-sshkey 2026-05-15 16:38:49.912823 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-15 16:38:49.912854 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-15 16:38:49.912873 | debian-bookworm -> localhost | | .o. .o.=B.=| 2026-05-15 16:38:49.912892 | debian-bookworm -> localhost | | . . +..@o| 2026-05-15 16:38:49.912910 | debian-bookworm -> localhost | | . .++ B*oo| 2026-05-15 16:38:49.912926 | debian-bookworm -> localhost | | .o*o+o=.o| 2026-05-15 16:38:49.912943 | debian-bookworm -> localhost | | S++++...o| 2026-05-15 16:38:49.912966 | debian-bookworm -> localhost | | ..o=.. .| 2026-05-15 16:38:49.912983 | debian-bookworm -> localhost | | .+ + | 2026-05-15 16:38:49.913000 | debian-bookworm -> localhost | | + . E | 2026-05-15 16:38:49.913018 | debian-bookworm -> localhost | | . | 2026-05-15 16:38:49.913035 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-15 16:38:49.913073 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.931820 2026-05-15 16:38:49.918236 | 2026-05-15 16:38:49.918322 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-15 16:38:49.954778 | debian-bookworm | ok 2026-05-15 16:38:49.967618 | debian-bookworm | included: /var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-15 16:38:49.992547 | 2026-05-15 16:38:49.992667 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-15 16:38:50.022804 | debian-bookworm | skipping: Conditional result was False 2026-05-15 16:38:50.029620 | 2026-05-15 16:38:50.029727 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-15 16:38:50.796037 | debian-bookworm | changed 2026-05-15 16:38:50.803665 | 2026-05-15 16:38:50.803746 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-15 16:38:51.095236 | debian-bookworm | ok 2026-05-15 16:38:51.100725 | 2026-05-15 16:38:51.100832 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-15 16:38:51.873473 | debian-bookworm | changed 2026-05-15 16:38:51.883446 | 2026-05-15 16:38:51.883539 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-15 16:38:52.517442 | debian-bookworm | changed 2026-05-15 16:38:52.531405 | 2026-05-15 16:38:52.531603 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-15 16:38:52.557954 | debian-bookworm | skipping: Conditional result was False 2026-05-15 16:38:52.569253 | 2026-05-15 16:38:52.569429 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-15 16:38:52.949006 | debian-bookworm -> localhost | changed 2026-05-15 16:38:52.961901 | 2026-05-15 16:38:52.961986 | TASK [add-build-sshkey : Add back temp key] 2026-05-15 16:38:53.324457 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/b7987cd66aa24a7ebc902a6daf846bfe_id_rsa (zuul-build-sshkey) 2026-05-15 16:38:53.324672 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014299 2026-05-15 16:38:53.333486 | 2026-05-15 16:38:53.333583 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-15 16:38:53.728520 | debian-bookworm | ok 2026-05-15 16:38:53.735535 | 2026-05-15 16:38:53.735655 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-15 16:38:53.759166 | debian-bookworm | skipping: Conditional result was False 2026-05-15 16:38:53.770234 | 2026-05-15 16:38:53.770336 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-15 16:38:54.210645 | debian-bookworm | ok 2026-05-15 16:38:54.226908 | 2026-05-15 16:38:54.227012 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-15 16:38:54.268585 | debian-bookworm | ok 2026-05-15 16:38:54.279095 | 2026-05-15 16:38:54.279214 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-15 16:38:54.835477 | debian-bookworm -> localhost | ok 2026-05-15 16:38:54.841817 | 2026-05-15 16:38:54.841902 | TASK [validate-host : Collect information about the host] 2026-05-15 16:38:56.147865 | debian-bookworm | ok 2026-05-15 16:38:56.166803 | 2026-05-15 16:38:56.166930 | TASK [validate-host : Sanitize hostname] 2026-05-15 16:38:56.326755 | debian-bookworm | ok 2026-05-15 16:38:56.373266 | 2026-05-15 16:38:56.373374 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-15 16:38:57.148257 | debian-bookworm -> localhost | changed 2026-05-15 16:38:57.153773 | 2026-05-15 16:38:57.153870 | TASK [validate-host : Collect information about zuul worker] 2026-05-15 16:38:57.736648 | debian-bookworm | ok 2026-05-15 16:38:57.741079 | 2026-05-15 16:38:57.741179 | TASK [validate-host : Write out all zuul information for each host] 2026-05-15 16:38:58.407598 | debian-bookworm -> localhost | changed 2026-05-15 16:38:58.419799 | 2026-05-15 16:38:58.419945 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-15 16:38:58.720810 | debian-bookworm | ok 2026-05-15 16:38:58.727453 | 2026-05-15 16:38:58.727598 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-15 16:39:00.416523 | debian-bookworm | changed: 2026-05-15 16:39:00.416748 | debian-bookworm | cd+++++++++ src/ 2026-05-15 16:39:00.416785 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-15 16:39:00.416811 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-15 16:39:00.416833 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-15 16:39:00.416853 | debian-bookworm | Containerfile 2026-05-15 16:39:00.416985 | debian-bookworm | Containerfile 2026-05-15 16:39:00.429753 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/logs" 2026-05-15 16:39:09.246509 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/artifacts" 2026-05-15 16:39:09.457247 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b7987cd66aa24a7ebc902a6daf846bfe/work/docs" 2026-05-15 16:39:09.475022 | 2026-05-15 16:39:09.475138 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-15 16:39:10.163065 | debian-bookworm | changed: 2026-05-15 16:39:10.163500 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-15 16:39:10.163564 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-15 16:39:10.163600 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-15 16:39:10.163665 | debian-bookworm | changed: All items complete 2026-05-15 16:39:10.163693 | 2026-05-15 16:39:10.739214 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 16:39:11.320613 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 16:39:11.351290 | 2026-05-15 16:39:11.351469 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-15 16:39:11.890751 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.013413 2026-05-15 16:39:12.154037 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009722 2026-05-15 16:39:12.178223 | 2026-05-15 16:39:12.178437 | PLAY RECAP 2026-05-15 16:39:12.178521 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-15 16:39:12.178566 | 2026-05-15 16:39:12.267739 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 16:39:12.269840 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 16:39:12.993664 | 2026-05-15 16:39:12.993785 | PLAY [Base post] 2026-05-15 16:39:13.005929 | 2026-05-15 16:39:13.006037 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-15 16:39:13.581765 | debian-bookworm | changed 2026-05-15 16:39:13.593099 | 2026-05-15 16:39:13.593291 | PLAY RECAP 2026-05-15 16:39:13.593374 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-15 16:39:13.593456 | 2026-05-15 16:39:13.797126 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 16:39:13.798022 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-15 16:39:14.654597 | 2026-05-15 16:39:14.654780 | PLAY [Base post-logs] 2026-05-15 16:39:14.666415 | 2026-05-15 16:39:14.666691 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-15 16:39:15.203954 | localhost | changed 2026-05-15 16:39:15.223289 | 2026-05-15 16:39:15.223481 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-15 16:39:15.261303 | localhost | ok 2026-05-15 16:39:15.264730 | 2026-05-15 16:39:15.264846 | TASK [Set zuul-log-path fact] 2026-05-15 16:39:15.293320 | localhost | ok 2026-05-15 16:39:15.305084 | 2026-05-15 16:39:15.305299 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 16:39:15.337622 | localhost | ok 2026-05-15 16:39:15.343352 | 2026-05-15 16:39:15.343550 | TASK [upload-logs : Create log directories] 2026-05-15 16:39:15.895091 | localhost | changed 2026-05-15 16:39:15.899499 | 2026-05-15 16:39:15.899636 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-15 16:39:16.442944 | localhost -> localhost | ok: Runtime: 0:00:00.007679 2026-05-15 16:39:16.447381 | 2026-05-15 16:39:16.447499 | TASK [upload-logs : Upload logs to log server] 2026-05-15 16:39:17.064970 | localhost | Output suppressed because no_log was given 2026-05-15 16:39:17.067221 | 2026-05-15 16:39:17.067336 | LOOP [upload-logs : Compress console log and json output] 2026-05-15 16:39:17.118720 | localhost | skipping: Conditional result was False 2026-05-15 16:39:17.124604 | localhost | skipping: Conditional result was False 2026-05-15 16:39:17.135640 | 2026-05-15 16:39:17.135757 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-15 16:39:17.183448 | localhost | skipping: Conditional result was False 2026-05-15 16:39:17.183771 | 2026-05-15 16:39:17.188980 | localhost | skipping: Conditional result was False 2026-05-15 16:39:17.192698 | 2026-05-15 16:39:17.192801 | LOOP [upload-logs : Upload console log and json output]