2026-05-12 03:12:43.844041 | Job console starting 2026-05-12 03:12:43.864107 | Updating git repos 2026-05-12 03:12:43.900112 | Cloning repos into workspace 2026-05-12 03:12:43.981053 | Restoring repo states 2026-05-12 03:12:44.005904 | Merging changes 2026-05-12 03:12:44.005926 | Checking out repos 2026-05-12 03:12:44.067934 | Preparing playbooks 2026-05-12 03:12:44.990387 | Running Ansible setup 2026-05-12 03:12:50.097089 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-12 03:12:51.020767 | 2026-05-12 03:12:51.020959 | PLAY [Base pre] 2026-05-12 03:12:51.050899 | 2026-05-12 03:12:51.051080 | TASK [Setup log path fact] 2026-05-12 03:12:51.100277 | debian-bookworm | ok 2026-05-12 03:12:51.119071 | 2026-05-12 03:12:51.119242 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-12 03:12:51.148837 | debian-bookworm | ok 2026-05-12 03:12:51.167223 | 2026-05-12 03:12:51.167429 | TASK [emit-job-header : Print job information] 2026-05-12 03:12:51.257896 | # Job Information 2026-05-12 03:12:51.258119 | Ansible Version: 2.16.14 2026-05-12 03:12:51.258156 | Job: hadolint 2026-05-12 03:12:51.258190 | Pipeline: periodic-daily 2026-05-12 03:12:51.258214 | Executor: 521e9411259a 2026-05-12 03:12:51.258234 | Triggered by: https://github.com/osism/cfg-cookiecutter 2026-05-12 03:12:51.258256 | Event ID: 1dfec04aab264988bdedf7c79c757827 2026-05-12 03:12:51.263446 | 2026-05-12 03:12:51.263580 | LOOP [emit-job-header : Print node information] 2026-05-12 03:12:51.430954 | debian-bookworm | ok: 2026-05-12 03:12:51.431177 | debian-bookworm | # Node Information 2026-05-12 03:12:51.431212 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-12 03:12:51.431238 | debian-bookworm | Hostname: debian 2026-05-12 03:12:51.431260 | debian-bookworm | Username: zuul 2026-05-12 03:12:51.431281 | debian-bookworm | Distro: Debian 12.13 2026-05-12 03:12:51.431326 | debian-bookworm | Provider: regiocloud-a 2026-05-12 03:12:51.431348 | debian-bookworm | Region: 2026-05-12 03:12:51.431369 | debian-bookworm | Label: debian-bookworm 2026-05-12 03:12:51.431390 | debian-bookworm | Product Name: OpenStack Nova 2026-05-12 03:12:51.431410 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe84:82e2 2026-05-12 03:12:51.449132 | 2026-05-12 03:12:51.449328 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-12 03:12:52.434899 | debian-bookworm -> localhost | changed 2026-05-12 03:12:52.443208 | 2026-05-12 03:12:52.443380 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-12 03:12:54.045601 | debian-bookworm -> localhost | changed 2026-05-12 03:12:54.068135 | 2026-05-12 03:12:54.068309 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-12 03:12:54.886462 | debian-bookworm -> localhost | ok 2026-05-12 03:12:54.893144 | 2026-05-12 03:12:54.893338 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-12 03:12:54.940295 | debian-bookworm | ok 2026-05-12 03:12:54.973678 | debian-bookworm | included: /var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-12 03:12:54.980585 | 2026-05-12 03:12:54.980712 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-12 03:12:59.927648 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-12 03:12:59.927840 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/bbf34ecc0ac949f5bac9563055bc8603_id_rsa 2026-05-12 03:12:59.927878 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/bbf34ecc0ac949f5bac9563055bc8603_id_rsa.pub 2026-05-12 03:12:59.927905 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-12 03:12:59.927930 | debian-bookworm -> localhost | SHA256:0IaZ3VXqHBv7RkgQH02+6BIAJLycKR+B0jd5SC5+2hM zuul-build-sshkey 2026-05-12 03:12:59.927952 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-12 03:12:59.927982 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-12 03:12:59.928004 | debian-bookworm -> localhost | | . +o+o o.o+o | 2026-05-12 03:12:59.928025 | debian-bookworm -> localhost | |. o.B..B . + +. | 2026-05-12 03:12:59.928045 | debian-bookworm -> localhost | | ..o.B= = . * . | 2026-05-12 03:12:59.928064 | debian-bookworm -> localhost | | ...* o . + B . | 2026-05-12 03:12:59.928084 | debian-bookworm -> localhost | | .oE. S . B o | 2026-05-12 03:12:59.928109 | debian-bookworm -> localhost | | +.. o o | 2026-05-12 03:12:59.928131 | debian-bookworm -> localhost | | . o . . o | 2026-05-12 03:12:59.928150 | debian-bookworm -> localhost | | . . . | 2026-05-12 03:12:59.928171 | debian-bookworm -> localhost | | | 2026-05-12 03:12:59.928192 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-12 03:12:59.928244 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.168520 2026-05-12 03:12:59.935509 | 2026-05-12 03:12:59.935616 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-12 03:12:59.953984 | debian-bookworm | ok 2026-05-12 03:12:59.963923 | debian-bookworm | included: /var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-12 03:12:59.974190 | 2026-05-12 03:12:59.974311 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-12 03:12:59.989059 | debian-bookworm | skipping: Conditional result was False 2026-05-12 03:12:59.996737 | 2026-05-12 03:12:59.996842 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-12 03:13:00.695242 | debian-bookworm | changed 2026-05-12 03:13:00.706654 | 2026-05-12 03:13:00.706884 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-12 03:13:00.999863 | debian-bookworm | ok 2026-05-12 03:13:01.009256 | 2026-05-12 03:13:01.009399 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-12 03:13:01.715153 | debian-bookworm | changed 2026-05-12 03:13:01.721797 | 2026-05-12 03:13:01.721901 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-12 03:13:02.539953 | debian-bookworm | changed 2026-05-12 03:13:02.545799 | 2026-05-12 03:13:02.545902 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-12 03:13:02.574059 | debian-bookworm | skipping: Conditional result was False 2026-05-12 03:13:02.580181 | 2026-05-12 03:13:02.580308 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-12 03:13:03.203601 | debian-bookworm -> localhost | changed 2026-05-12 03:13:03.216166 | 2026-05-12 03:13:03.216361 | TASK [add-build-sshkey : Add back temp key] 2026-05-12 03:13:03.940136 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/bbf34ecc0ac949f5bac9563055bc8603_id_rsa (zuul-build-sshkey) 2026-05-12 03:13:03.940447 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013938 2026-05-12 03:13:03.949125 | 2026-05-12 03:13:03.949260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-12 03:13:04.714201 | debian-bookworm | ok 2026-05-12 03:13:04.758695 | 2026-05-12 03:13:04.758941 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-12 03:13:04.821163 | debian-bookworm | skipping: Conditional result was False 2026-05-12 03:13:04.846663 | 2026-05-12 03:13:04.846828 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-12 03:13:05.473573 | debian-bookworm | ok 2026-05-12 03:13:05.497574 | 2026-05-12 03:13:05.497733 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-12 03:13:05.539297 | debian-bookworm | ok 2026-05-12 03:13:05.544768 | 2026-05-12 03:13:05.544914 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-12 03:13:06.204658 | debian-bookworm -> localhost | ok 2026-05-12 03:13:06.212399 | 2026-05-12 03:13:06.212540 | TASK [validate-host : Collect information about the host] 2026-05-12 03:13:07.770362 | debian-bookworm | ok 2026-05-12 03:13:07.781002 | 2026-05-12 03:13:07.781150 | TASK [validate-host : Sanitize hostname] 2026-05-12 03:13:07.966341 | debian-bookworm | ok 2026-05-12 03:13:08.079460 | 2026-05-12 03:13:08.089161 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-12 03:13:09.687470 | debian-bookworm -> localhost | changed 2026-05-12 03:13:09.695040 | 2026-05-12 03:13:09.695179 | TASK [validate-host : Collect information about zuul worker] 2026-05-12 03:13:10.403382 | debian-bookworm | ok 2026-05-12 03:13:10.408189 | 2026-05-12 03:13:10.408309 | TASK [validate-host : Write out all zuul information for each host] 2026-05-12 03:13:11.978169 | debian-bookworm -> localhost | changed 2026-05-12 03:13:11.987316 | 2026-05-12 03:13:11.987416 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-12 03:13:12.315615 | debian-bookworm | ok 2026-05-12 03:13:12.323163 | 2026-05-12 03:13:12.323309 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-12 03:13:13.498689 | debian-bookworm | changed: 2026-05-12 03:13:13.498883 | debian-bookworm | cd+++++++++ src/ 2026-05-12 03:13:13.498920 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-12 03:13:13.498944 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-12 03:13:13.498966 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-05-12 03:13:13.498986 | debian-bookworm | Containerfile 2026-05-12 03:13:13.499316 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/logs" 2026-05-12 03:13:23.798199 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/artifacts" 2026-05-12 03:13:24.187784 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bbf34ecc0ac949f5bac9563055bc8603/work/docs" 2026-05-12 03:13:24.206213 | 2026-05-12 03:13:24.206406 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-12 03:13:25.039400 | debian-bookworm | changed: 2026-05-12 03:13:25.039751 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-12 03:13:25.039803 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-12 03:13:25.039844 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-12 03:13:25.039905 | debian-bookworm | changed: All items complete 2026-05-12 03:13:25.039940 | 2026-05-12 03:13:25.644479 | debian-bookworm | changed: .d..t...... ./ 2026-05-12 03:13:26.261816 | debian-bookworm | changed: .d..t...... ./ 2026-05-12 03:13:26.289221 | 2026-05-12 03:13:26.289409 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-12 03:13:26.333018 | debian-bookworm | skipping: Conditional result was False 2026-05-12 03:13:26.337672 | debian-bookworm | skipping: Conditional result was False 2026-05-12 03:13:26.361556 | 2026-05-12 03:13:26.361678 | PLAY RECAP 2026-05-12 03:13:26.361736 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-12 03:13:26.361760 | 2026-05-12 03:13:26.529794 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-12 03:13:26.530719 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-12 03:13:27.522667 | 2026-05-12 03:13:27.522878 | PLAY [Base post] 2026-05-12 03:13:27.537982 | 2026-05-12 03:13:27.538151 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-12 03:13:28.270187 | debian-bookworm | changed 2026-05-12 03:13:28.288061 | 2026-05-12 03:13:28.288328 | PLAY RECAP 2026-05-12 03:13:28.288411 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-12 03:13:28.288478 | 2026-05-12 03:13:28.615263 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-12 03:13:28.616122 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-12 03:13:29.698869 | 2026-05-12 03:13:29.699046 | PLAY [Base post-logs] 2026-05-12 03:13:29.721559 | 2026-05-12 03:13:29.721721 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-12 03:13:30.168218 | localhost | changed 2026-05-12 03:13:30.181635 | 2026-05-12 03:13:30.181796 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-12 03:13:30.207381 | localhost | ok 2026-05-12 03:13:30.210483 | 2026-05-12 03:13:30.210583 | TASK [Set zuul-log-path fact] 2026-05-12 03:13:30.226645 | localhost | ok 2026-05-12 03:13:30.234648 | 2026-05-12 03:13:30.234762 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-12 03:13:30.261070 | localhost | ok 2026-05-12 03:13:30.266973 | 2026-05-12 03:13:30.267137 | TASK [upload-logs : Create log directories] 2026-05-12 03:13:30.814226 | localhost | changed 2026-05-12 03:13:30.817492 | 2026-05-12 03:13:30.817611 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-12 03:13:31.331005 | localhost -> localhost | ok: Runtime: 0:00:00.004040 2026-05-12 03:13:31.342559 | 2026-05-12 03:13:31.342755 | TASK [upload-logs : Upload logs to log server] 2026-05-12 03:13:31.959526 | localhost | Output suppressed because no_log was given 2026-05-12 03:13:31.961401 | 2026-05-12 03:13:31.961509 | LOOP [upload-logs : Compress console log and json output] 2026-05-12 03:13:32.012867 | localhost | skipping: Conditional result was False 2026-05-12 03:13:32.019118 | localhost | skipping: Conditional result was False 2026-05-12 03:13:32.028155 | 2026-05-12 03:13:32.028310 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-12 03:13:32.081537 | localhost | skipping: Conditional result was False 2026-05-12 03:13:32.082456 | 2026-05-12 03:13:32.085911 | localhost | skipping: Conditional result was False 2026-05-12 03:13:32.097428 | 2026-05-12 03:13:32.097605 | LOOP [upload-logs : Upload console log and json output]