2026-05-18 16:36:53.137233 | Job console starting 2026-05-18 16:36:53.165159 | Updating git repos 2026-05-18 16:36:53.245181 | Cloning repos into workspace 2026-05-18 16:36:53.365295 | Restoring repo states 2026-05-18 16:36:53.392330 | Merging changes 2026-05-18 16:36:54.074710 | Checking out repos 2026-05-18 16:36:54.111527 | Preparing playbooks 2026-05-18 16:36:54.995960 | Running Ansible setup 2026-05-18 16:36:59.924946 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 16:37:00.761088 | 2026-05-18 16:37:00.761318 | PLAY [Base pre] 2026-05-18 16:37:00.833379 | 2026-05-18 16:37:00.833701 | TASK [Setup log path fact] 2026-05-18 16:37:00.856063 | debian-bookworm | ok 2026-05-18 16:37:00.875824 | 2026-05-18 16:37:00.876000 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 16:37:00.907400 | debian-bookworm | ok 2026-05-18 16:37:00.921849 | 2026-05-18 16:37:00.922059 | TASK [emit-job-header : Print job information] 2026-05-18 16:37:00.961969 | # Job Information 2026-05-18 16:37:00.962157 | Ansible Version: 2.16.14 2026-05-18 16:37:00.962191 | Job: hadolint 2026-05-18 16:37:00.962224 | Pipeline: check 2026-05-18 16:37:00.962246 | Executor: 521e9411259a 2026-05-18 16:37:00.962266 | Triggered by: https://github.com/osism/python-osism/pull/2279 2026-05-18 16:37:00.962287 | Event ID: c0033d00-52d7-11f1-9968-99d020f86c26 2026-05-18 16:37:00.967290 | 2026-05-18 16:37:00.967409 | LOOP [emit-job-header : Print node information] 2026-05-18 16:37:01.083338 | debian-bookworm | ok: 2026-05-18 16:37:01.090913 | debian-bookworm | # Node Information 2026-05-18 16:37:01.091022 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 16:37:01.091053 | debian-bookworm | Hostname: debian 2026-05-18 16:37:01.091077 | debian-bookworm | Username: zuul 2026-05-18 16:37:01.091098 | debian-bookworm | Distro: Debian 12.14 2026-05-18 16:37:01.091124 | debian-bookworm | Provider: regiocloud-a 2026-05-18 16:37:01.091146 | debian-bookworm | Region: 2026-05-18 16:37:01.091166 | debian-bookworm | Label: debian-bookworm 2026-05-18 16:37:01.091187 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 16:37:01.091206 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:f9e1 2026-05-18 16:37:01.105431 | 2026-05-18 16:37:01.105574 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 16:37:02.113461 | debian-bookworm -> localhost | changed 2026-05-18 16:37:02.121409 | 2026-05-18 16:37:02.121559 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 16:37:03.820135 | debian-bookworm -> localhost | changed 2026-05-18 16:37:03.832424 | 2026-05-18 16:37:03.832566 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 16:37:04.170483 | debian-bookworm -> localhost | ok 2026-05-18 16:37:04.176236 | 2026-05-18 16:37:04.176326 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 16:37:04.196516 | debian-bookworm | ok 2026-05-18 16:37:04.212915 | debian-bookworm | included: /var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 16:37:04.218692 | 2026-05-18 16:37:04.218781 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 16:37:06.560795 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 16:37:06.560975 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/aa42a7f712c6449b877527152a7ce533_id_rsa 2026-05-18 16:37:06.561011 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/aa42a7f712c6449b877527152a7ce533_id_rsa.pub 2026-05-18 16:37:06.561037 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 16:37:06.561061 | debian-bookworm -> localhost | SHA256:49tZsOCFwh8M8A2a3VD9G9ySsd8JNqQkwdCcptRXOGw zuul-build-sshkey 2026-05-18 16:37:06.561082 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 16:37:06.561113 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 16:37:06.561135 | debian-bookworm -> localhost | | . ooBo+ o. | 2026-05-18 16:37:06.561157 | debian-bookworm -> localhost | | * * O.E.. | 2026-05-18 16:37:06.561178 | debian-bookworm -> localhost | | o = = =o+= | 2026-05-18 16:37:06.561198 | debian-bookworm -> localhost | | . + . .B+. | 2026-05-18 16:37:06.561218 | debian-bookworm -> localhost | | o S o .=o..| 2026-05-18 16:37:06.561240 | debian-bookworm -> localhost | | = = o. ...| 2026-05-18 16:37:06.561260 | debian-bookworm -> localhost | | + . . | 2026-05-18 16:37:06.561279 | debian-bookworm -> localhost | | o o | 2026-05-18 16:37:06.561300 | debian-bookworm -> localhost | | . o | 2026-05-18 16:37:06.561319 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 16:37:06.561372 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.856426 2026-05-18 16:37:06.567964 | 2026-05-18 16:37:06.568067 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 16:37:06.586491 | debian-bookworm | ok 2026-05-18 16:37:06.597159 | debian-bookworm | included: /var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 16:37:06.606117 | 2026-05-18 16:37:06.606216 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 16:37:06.629216 | debian-bookworm | skipping: Conditional result was False 2026-05-18 16:37:06.634947 | 2026-05-18 16:37:06.635046 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 16:37:07.237451 | debian-bookworm | changed 2026-05-18 16:37:07.245969 | 2026-05-18 16:37:07.246109 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 16:37:07.475138 | debian-bookworm | ok 2026-05-18 16:37:07.485253 | 2026-05-18 16:37:07.485377 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 16:37:08.089308 | debian-bookworm | changed 2026-05-18 16:37:08.096940 | 2026-05-18 16:37:08.097028 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 16:37:08.685627 | debian-bookworm | changed 2026-05-18 16:37:08.696039 | 2026-05-18 16:37:08.696134 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 16:37:08.720653 | debian-bookworm | skipping: Conditional result was False 2026-05-18 16:37:08.729189 | 2026-05-18 16:37:08.729280 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 16:37:09.175630 | debian-bookworm -> localhost | changed 2026-05-18 16:37:09.185983 | 2026-05-18 16:37:09.186073 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 16:37:09.544600 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/aa42a7f712c6449b877527152a7ce533_id_rsa (zuul-build-sshkey) 2026-05-18 16:37:09.544814 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030922 2026-05-18 16:37:09.552258 | 2026-05-18 16:37:09.552352 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 16:37:09.953399 | debian-bookworm | ok 2026-05-18 16:37:09.958421 | 2026-05-18 16:37:09.958519 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 16:37:09.985467 | debian-bookworm | skipping: Conditional result was False 2026-05-18 16:37:10.000232 | 2026-05-18 16:37:10.000344 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 16:37:10.385047 | debian-bookworm | ok 2026-05-18 16:37:10.398211 | 2026-05-18 16:37:10.398317 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 16:37:10.426128 | debian-bookworm | ok 2026-05-18 16:37:10.432932 | 2026-05-18 16:37:10.433040 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 16:37:10.720071 | debian-bookworm -> localhost | ok 2026-05-18 16:37:10.726143 | 2026-05-18 16:37:10.726241 | TASK [validate-host : Collect information about the host] 2026-05-18 16:37:11.803969 | debian-bookworm | ok 2026-05-18 16:37:11.814401 | 2026-05-18 16:37:11.814526 | TASK [validate-host : Sanitize hostname] 2026-05-18 16:37:11.936139 | debian-bookworm | ok 2026-05-18 16:37:11.980943 | 2026-05-18 16:37:11.981080 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 16:37:12.590063 | debian-bookworm -> localhost | changed 2026-05-18 16:37:12.598950 | 2026-05-18 16:37:12.599119 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 16:37:13.032140 | debian-bookworm | ok 2026-05-18 16:37:13.037109 | 2026-05-18 16:37:13.041885 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 16:37:13.832933 | debian-bookworm -> localhost | changed 2026-05-18 16:37:13.843272 | 2026-05-18 16:37:13.843405 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 16:37:14.123685 | debian-bookworm | ok 2026-05-18 16:37:14.129883 | 2026-05-18 16:37:14.130021 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 16:37:15.318306 | debian-bookworm | changed: 2026-05-18 16:37:15.318575 | debian-bookworm | cd+++++++++ src/ 2026-05-18 16:37:15.318625 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 16:37:15.318659 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 16:37:15.318747 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-18 16:37:15.318777 | debian-bookworm | Containerfile 2026-05-18 16:37:15.319004 | debian-bookworm | Containerfile 2026-05-18 16:37:15.331895 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/logs" 2026-05-18 16:37:22.959132 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/artifacts" 2026-05-18 16:37:23.269433 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/aa42a7f712c6449b877527152a7ce533/work/docs" 2026-05-18 16:37:23.289757 | 2026-05-18 16:37:23.289974 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 16:37:24.075548 | debian-bookworm | changed: 2026-05-18 16:37:24.075891 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 16:37:24.075957 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 16:37:24.076002 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 16:37:24.076062 | debian-bookworm | changed: All items complete 2026-05-18 16:37:24.076172 | 2026-05-18 16:37:24.702659 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 16:37:25.337748 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 16:37:25.374742 | 2026-05-18 16:37:25.375195 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 16:37:25.922282 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010356 2026-05-18 16:37:26.229781 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.006227 2026-05-18 16:37:26.240046 | 2026-05-18 16:37:26.240152 | PLAY RECAP 2026-05-18 16:37:26.240212 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 16:37:26.240249 | 2026-05-18 16:37:26.420085 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 16:37:26.422254 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 16:37:27.218097 | 2026-05-18 16:37:27.218268 | PLAY [Base post] 2026-05-18 16:37:27.233637 | 2026-05-18 16:37:27.233825 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 16:37:27.973568 | debian-bookworm | changed 2026-05-18 16:37:27.980828 | 2026-05-18 16:37:27.980965 | PLAY RECAP 2026-05-18 16:37:27.981031 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 16:37:27.981096 | 2026-05-18 16:37:28.149066 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 16:37:28.150160 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 16:37:28.986950 | 2026-05-18 16:37:28.987144 | PLAY [Base post-logs] 2026-05-18 16:37:29.009975 | 2026-05-18 16:37:29.010153 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 16:37:29.526787 | localhost | changed 2026-05-18 16:37:29.546240 | 2026-05-18 16:37:29.546496 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 16:37:29.587050 | localhost | ok 2026-05-18 16:37:29.593986 | 2026-05-18 16:37:29.594182 | TASK [Set zuul-log-path fact] 2026-05-18 16:37:29.623279 | localhost | ok 2026-05-18 16:37:29.636828 | 2026-05-18 16:37:29.637033 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 16:37:29.677611 | localhost | ok 2026-05-18 16:37:29.682129 | 2026-05-18 16:37:29.682271 | TASK [upload-logs : Create log directories] 2026-05-18 16:37:30.213183 | localhost | changed 2026-05-18 16:37:30.217925 | 2026-05-18 16:37:30.218087 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 16:37:30.764266 | localhost -> localhost | ok: Runtime: 0:00:00.004630 2026-05-18 16:37:30.771147 | 2026-05-18 16:37:30.771300 | TASK [upload-logs : Upload logs to log server] 2026-05-18 16:37:31.404555 | localhost | Output suppressed because no_log was given 2026-05-18 16:37:31.410019 | 2026-05-18 16:37:31.410162 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 16:37:31.461751 | localhost | skipping: Conditional result was False 2026-05-18 16:37:31.467049 | localhost | skipping: Conditional result was False 2026-05-18 16:37:31.477787 | 2026-05-18 16:37:31.477959 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 16:37:31.548844 | localhost | skipping: Conditional result was False 2026-05-18 16:37:31.549989 | 2026-05-18 16:37:31.555260 | localhost | skipping: Conditional result was False 2026-05-18 16:37:31.569357 | 2026-05-18 16:37:31.569636 | LOOP [upload-logs : Upload console log and json output]