2026-04-30 03:06:19.537712 | Job console starting 2026-04-30 03:06:19.575364 | Updating git repos 2026-04-30 03:06:19.612148 | Cloning repos into workspace 2026-04-30 03:06:19.667577 | Restoring repo states 2026-04-30 03:06:19.708099 | Merging changes 2026-04-30 03:06:19.708122 | Checking out repos 2026-04-30 03:06:19.794415 | Preparing playbooks 2026-04-30 03:06:21.303290 | Running Ansible setup 2026-04-30 03:06:27.813492 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-30 03:06:29.377303 | 2026-04-30 03:06:29.377468 | PLAY [Base pre] 2026-04-30 03:06:29.475776 | 2026-04-30 03:06:29.475917 | TASK [Setup log path fact] 2026-04-30 03:06:29.493983 | debian-bookworm | ok 2026-04-30 03:06:29.525794 | 2026-04-30 03:06:29.525914 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 03:06:29.553567 | debian-bookworm | ok 2026-04-30 03:06:29.580500 | 2026-04-30 03:06:29.580605 | TASK [emit-job-header : Print job information] 2026-04-30 03:06:29.647785 | # Job Information 2026-04-30 03:06:29.647939 | Ansible Version: 2.16.14 2026-04-30 03:06:29.647968 | Job: hadolint 2026-04-30 03:06:29.647997 | Pipeline: periodic-daily 2026-04-30 03:06:29.648015 | Executor: 521e9411259a 2026-04-30 03:06:29.648033 | Triggered by: https://github.com/osism/rookify 2026-04-30 03:06:29.648051 | Event ID: f1a46e87cab448368a1f84e22966eddd 2026-04-30 03:06:29.653122 | 2026-04-30 03:06:29.653220 | LOOP [emit-job-header : Print node information] 2026-04-30 03:06:29.780268 | debian-bookworm | ok: 2026-04-30 03:06:29.780482 | debian-bookworm | # Node Information 2026-04-30 03:06:29.780527 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-30 03:06:29.780558 | debian-bookworm | Hostname: debian 2026-04-30 03:06:29.780581 | debian-bookworm | Username: zuul 2026-04-30 03:06:29.780602 | debian-bookworm | Distro: Debian 12.13 2026-04-30 03:06:29.780627 | debian-bookworm | Provider: regiocloud-a 2026-04-30 03:06:29.780654 | debian-bookworm | Region: 2026-04-30 03:06:29.780681 | debian-bookworm | Label: debian-bookworm 2026-04-30 03:06:29.780706 | debian-bookworm | Product Name: OpenStack Nova 2026-04-30 03:06:29.780731 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febe:559d 2026-04-30 03:06:29.792758 | 2026-04-30 03:06:29.792959 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-30 03:06:31.304522 | debian-bookworm -> localhost | changed 2026-04-30 03:06:31.312966 | 2026-04-30 03:06:31.313079 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-30 03:06:34.101141 | debian-bookworm -> localhost | changed 2026-04-30 03:06:34.111104 | 2026-04-30 03:06:34.111209 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-30 03:06:34.968437 | debian-bookworm -> localhost | ok 2026-04-30 03:06:34.973688 | 2026-04-30 03:06:34.973797 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-30 03:06:35.023934 | debian-bookworm | ok 2026-04-30 03:06:35.073179 | debian-bookworm | included: /var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-30 03:06:35.104106 | 2026-04-30 03:06:35.104214 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-30 03:06:37.713261 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-30 03:06:37.714263 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/b7dfd7d754d0476eb752ca8e1e29de20_id_rsa 2026-04-30 03:06:37.714334 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/b7dfd7d754d0476eb752ca8e1e29de20_id_rsa.pub 2026-04-30 03:06:37.714368 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-30 03:06:37.714394 | debian-bookworm -> localhost | SHA256:j+a5i41t+CUjIQdhi0wOvXRVGIZ4dKF080swqiEC38M zuul-build-sshkey 2026-04-30 03:06:37.714425 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-30 03:06:37.714462 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-30 03:06:37.714485 | debian-bookworm -> localhost | |o..o=o@=. | 2026-04-30 03:06:37.714508 | debian-bookworm -> localhost | |.*+*+O.= | 2026-04-30 03:06:37.714529 | debian-bookworm -> localhost | |o.*+E o | 2026-04-30 03:06:37.714549 | debian-bookworm -> localhost | |...o o . . | 2026-04-30 03:06:37.714569 | debian-bookworm -> localhost | | . . o S | 2026-04-30 03:06:37.714596 | debian-bookworm -> localhost | | o . o | 2026-04-30 03:06:37.714617 | debian-bookworm -> localhost | | ..= o | 2026-04-30 03:06:37.714636 | debian-bookworm -> localhost | | .O.= | 2026-04-30 03:06:37.714658 | debian-bookworm -> localhost | | ooOo | 2026-04-30 03:06:37.714679 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-30 03:06:37.714731 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.338448 2026-04-30 03:06:37.722334 | 2026-04-30 03:06:37.722572 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-30 03:06:37.767091 | debian-bookworm | ok 2026-04-30 03:06:37.788350 | debian-bookworm | included: /var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-30 03:06:37.810209 | 2026-04-30 03:06:37.810355 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-30 03:06:37.867400 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:06:37.909722 | 2026-04-30 03:06:37.909845 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-30 03:06:38.999481 | debian-bookworm | changed 2026-04-30 03:06:39.004274 | 2026-04-30 03:06:39.004387 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-30 03:06:39.331098 | debian-bookworm | ok 2026-04-30 03:06:39.335722 | 2026-04-30 03:06:39.335803 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-30 03:06:40.279999 | debian-bookworm | changed 2026-04-30 03:06:40.297852 | 2026-04-30 03:06:40.297952 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-30 03:06:41.068617 | debian-bookworm | changed 2026-04-30 03:06:41.079615 | 2026-04-30 03:06:41.079716 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-30 03:06:41.103844 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:06:41.111241 | 2026-04-30 03:06:41.111376 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-30 03:06:41.697402 | debian-bookworm -> localhost | changed 2026-04-30 03:06:41.708259 | 2026-04-30 03:06:41.708373 | TASK [add-build-sshkey : Add back temp key] 2026-04-30 03:06:42.369231 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/b7dfd7d754d0476eb752ca8e1e29de20_id_rsa (zuul-build-sshkey) 2026-04-30 03:06:42.369479 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010336 2026-04-30 03:06:42.385352 | 2026-04-30 03:06:42.385576 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-30 03:06:42.859213 | debian-bookworm | ok 2026-04-30 03:06:42.865866 | 2026-04-30 03:06:42.865979 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-30 03:06:42.899528 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:06:42.908659 | 2026-04-30 03:06:42.908745 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-30 03:06:43.414913 | debian-bookworm | ok 2026-04-30 03:06:43.433767 | 2026-04-30 03:06:43.433906 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-30 03:06:43.463903 | debian-bookworm | ok 2026-04-30 03:06:43.469057 | 2026-04-30 03:06:43.469147 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-30 03:06:43.878293 | debian-bookworm -> localhost | ok 2026-04-30 03:06:43.885447 | 2026-04-30 03:06:43.885613 | TASK [validate-host : Collect information about the host] 2026-04-30 03:06:45.323764 | debian-bookworm | ok 2026-04-30 03:06:45.344198 | 2026-04-30 03:06:45.344742 | TASK [validate-host : Sanitize hostname] 2026-04-30 03:06:45.562801 | debian-bookworm | ok 2026-04-30 03:06:45.645220 | 2026-04-30 03:06:45.645406 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-30 03:06:46.955116 | debian-bookworm -> localhost | changed 2026-04-30 03:06:46.973266 | 2026-04-30 03:06:46.974244 | TASK [validate-host : Collect information about zuul worker] 2026-04-30 03:06:47.793856 | debian-bookworm | ok 2026-04-30 03:06:47.798480 | 2026-04-30 03:06:47.798601 | TASK [validate-host : Write out all zuul information for each host] 2026-04-30 03:06:48.928948 | debian-bookworm -> localhost | changed 2026-04-30 03:06:48.937154 | 2026-04-30 03:06:48.937259 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-30 03:06:49.253955 | debian-bookworm | ok 2026-04-30 03:06:49.258868 | 2026-04-30 03:06:49.258964 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-30 03:06:50.308473 | debian-bookworm | changed: 2026-04-30 03:06:50.308658 | debian-bookworm | cd+++++++++ src/ 2026-04-30 03:06:50.308693 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-30 03:06:50.308716 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-30 03:06:50.308737 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2026-04-30 03:06:50.308757 | debian-bookworm | Containerfile 2026-04-30 03:06:50.308908 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/logs" 2026-04-30 03:07:01.717656 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/artifacts" 2026-04-30 03:07:02.461970 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b7dfd7d754d0476eb752ca8e1e29de20/work/docs" 2026-04-30 03:07:02.503936 | 2026-04-30 03:07:02.504060 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-30 03:07:03.436142 | debian-bookworm | changed: 2026-04-30 03:07:03.437723 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-30 03:07:03.437788 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-30 03:07:03.437821 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-30 03:07:03.437876 | debian-bookworm | changed: All items complete 2026-04-30 03:07:03.437906 | 2026-04-30 03:07:04.093617 | debian-bookworm | changed: .d..t...... ./ 2026-04-30 03:07:04.797196 | debian-bookworm | changed: .d..t...... ./ 2026-04-30 03:07:04.834897 | 2026-04-30 03:07:04.835029 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-30 03:07:04.886515 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:07:04.895216 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:07:04.910494 | 2026-04-30 03:07:04.910700 | PLAY RECAP 2026-04-30 03:07:04.910909 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-04-30 03:07:04.911020 | 2026-04-30 03:07:05.125618 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-30 03:07:05.126575 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 03:07:06.515187 | 2026-04-30 03:07:06.515344 | PLAY [Base post] 2026-04-30 03:07:06.531498 | 2026-04-30 03:07:06.531630 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-30 03:07:07.272908 | debian-bookworm | changed 2026-04-30 03:07:07.284058 | 2026-04-30 03:07:07.284168 | PLAY RECAP 2026-04-30 03:07:07.284228 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-30 03:07:07.284291 | 2026-04-30 03:07:07.412174 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 03:07:07.412884 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-30 03:07:08.866117 | 2026-04-30 03:07:08.866269 | PLAY [Base post-logs] 2026-04-30 03:07:08.909947 | 2026-04-30 03:07:08.910099 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-30 03:07:10.199998 | localhost | changed 2026-04-30 03:07:10.217345 | 2026-04-30 03:07:10.217542 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-30 03:07:10.266191 | localhost | ok 2026-04-30 03:07:10.269781 | 2026-04-30 03:07:10.269875 | TASK [Set zuul-log-path fact] 2026-04-30 03:07:10.295558 | localhost | ok 2026-04-30 03:07:10.309009 | 2026-04-30 03:07:10.309125 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 03:07:10.376590 | localhost | ok 2026-04-30 03:07:10.379763 | 2026-04-30 03:07:10.379856 | TASK [upload-logs : Create log directories] 2026-04-30 03:07:12.104146 | localhost | changed 2026-04-30 03:07:12.107014 | 2026-04-30 03:07:12.107113 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-30 03:07:13.878044 | localhost -> localhost | ok: Runtime: 0:00:00.017326 2026-04-30 03:07:13.881773 | 2026-04-30 03:07:13.881870 | TASK [upload-logs : Upload logs to log server] 2026-04-30 03:07:15.302319 | localhost | Output suppressed because no_log was given 2026-04-30 03:07:15.303965 | 2026-04-30 03:07:15.304053 | LOOP [upload-logs : Compress console log and json output] 2026-04-30 03:07:15.464334 | localhost | skipping: Conditional result was False 2026-04-30 03:07:15.487694 | localhost | skipping: Conditional result was False 2026-04-30 03:07:15.493625 | 2026-04-30 03:07:15.493748 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-30 03:07:15.667207 | localhost | skipping: Conditional result was False 2026-04-30 03:07:15.667486 | 2026-04-30 03:07:15.685401 | localhost | skipping: Conditional result was False 2026-04-30 03:07:15.694374 | 2026-04-30 03:07:15.694512 | LOOP [upload-logs : Upload console log and json output]