2026-08-29 06:03:05.423354 | Job console starting 2026-08-29 06:03:05.446373 | Updating git repos 2026-08-29 06:03:05.485554 | Cloning repos into workspace 2026-08-29 06:03:05.539041 | Restoring repo states 2026-08-29 06:03:05.550493 | Merging changes 2026-08-29 06:03:05.550515 | Checking out repos 2026-08-29 06:03:05.599509 | Preparing playbooks 2026-08-29 06:03:06.568941 | Running Ansible setup 2026-08-29 06:03:12.993022 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-29 06:03:13.907075 | 2026-08-29 06:03:13.907264 | PLAY [Base pre] 2026-08-29 06:03:13.926635 | 2026-08-29 06:03:13.926799 | TASK [Setup log path fact] 2026-08-29 06:03:13.968050 | noble | ok 2026-08-29 06:03:13.987465 | 2026-08-29 06:03:13.987623 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-29 06:03:14.028060 | noble | ok 2026-08-29 06:03:14.040308 | 2026-08-29 06:03:14.040449 | TASK [emit-job-header : Print job information] 2026-08-29 06:03:14.082283 | # Job Information 2026-08-29 06:03:14.082479 | Ansible Version: 2.16.14 2026-08-29 06:03:14.082515 | Job: openstack-ironic-images-publish-osism-esp 2026-08-29 06:03:14.082549 | Pipeline: periodic-weekly 2026-08-29 06:03:14.082572 | Executor: 521e9411259a 2026-08-29 06:03:14.082593 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-08-29 06:03:14.082616 | Event ID: 6b59b14a9cb94acfb632360ebf11415c 2026-08-29 06:03:14.088371 | 2026-08-29 06:03:14.088483 | LOOP [emit-job-header : Print node information] 2026-08-29 06:03:14.205244 | noble | ok: 2026-08-29 06:03:14.205541 | noble | # Node Information 2026-08-29 06:03:14.205578 | noble | Inventory Hostname: noble 2026-08-29 06:03:14.205602 | noble | Hostname: ubuntu 2026-08-29 06:03:14.205625 | noble | Username: zuul 2026-08-29 06:03:14.205645 | noble | Distro: Ubuntu 24.04 2026-08-29 06:03:14.205668 | noble | Provider: regiocloud-a 2026-08-29 06:03:14.205689 | noble | Region: 2026-08-29 06:03:14.205709 | noble | Label: ubuntu-noble-uefi 2026-08-29 06:03:14.205729 | noble | Product Name: OpenStack Nova 2026-08-29 06:03:14.205782 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:48e6 2026-08-29 06:03:14.225187 | 2026-08-29 06:03:14.225345 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-29 06:03:14.869448 | noble -> localhost | changed 2026-08-29 06:03:14.891912 | 2026-08-29 06:03:14.892151 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-29 06:03:16.156528 | noble -> localhost | changed 2026-08-29 06:03:16.171257 | 2026-08-29 06:03:16.171403 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-29 06:03:16.542552 | noble -> localhost | ok 2026-08-29 06:03:16.550993 | 2026-08-29 06:03:16.551154 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-29 06:03:16.583069 | noble | ok 2026-08-29 06:03:16.613488 | noble | included: /var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-29 06:03:16.621279 | 2026-08-29 06:03:16.621406 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-29 06:03:18.127062 | noble -> localhost | Generating public/private rsa key pair. 2026-08-29 06:03:18.127396 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/08a941d5219c43c5813575b4cb9aeebe_id_rsa 2026-08-29 06:03:18.127445 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/08a941d5219c43c5813575b4cb9aeebe_id_rsa.pub 2026-08-29 06:03:18.127474 | noble -> localhost | The key fingerprint is: 2026-08-29 06:03:18.127501 | noble -> localhost | SHA256:rUd2tmbegWaSTq0CkloiTeg9RehCqtI0yHBfvPzZoo8 zuul-build-sshkey 2026-08-29 06:03:18.127527 | noble -> localhost | The key's randomart image is: 2026-08-29 06:03:18.127549 | noble -> localhost | +---[RSA 3072]----+ 2026-08-29 06:03:18.127573 | noble -> localhost | | .. | 2026-08-29 06:03:18.127610 | noble -> localhost | |.... .o | 2026-08-29 06:03:18.127632 | noble -> localhost | |=+...o . | 2026-08-29 06:03:18.127653 | noble -> localhost | |+o+...o . | 2026-08-29 06:03:18.127674 | noble -> localhost | |o=o... .So+ o | 2026-08-29 06:03:18.127704 | noble -> localhost | |+.+o+ . ++.= o | 2026-08-29 06:03:18.127726 | noble -> localhost | |.. +.. o..= O . | 2026-08-29 06:03:18.127808 | noble -> localhost | | . ...+ O . . | 2026-08-29 06:03:18.127835 | noble -> localhost | | E...o . . | 2026-08-29 06:03:18.127855 | noble -> localhost | +----[SHA256]-----+ 2026-08-29 06:03:18.127921 | noble -> localhost | ok: Runtime: 0:00:00.916511 2026-08-29 06:03:18.136347 | 2026-08-29 06:03:18.136476 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-29 06:03:18.180141 | noble | ok 2026-08-29 06:03:18.191354 | noble | included: /var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-29 06:03:18.202655 | 2026-08-29 06:03:18.202812 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-29 06:03:18.231025 | noble | skipping: Conditional result was False 2026-08-29 06:03:18.238810 | 2026-08-29 06:03:18.238964 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-29 06:03:18.901412 | noble | changed 2026-08-29 06:03:18.909223 | 2026-08-29 06:03:18.909368 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-29 06:03:19.234377 | noble | ok 2026-08-29 06:03:19.246497 | 2026-08-29 06:03:19.246722 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-29 06:03:20.078926 | noble | changed 2026-08-29 06:03:20.089955 | 2026-08-29 06:03:20.090149 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-29 06:03:20.912184 | noble | changed 2026-08-29 06:03:20.920477 | 2026-08-29 06:03:20.920627 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-29 06:03:20.945229 | noble | skipping: Conditional result was False 2026-08-29 06:03:20.956141 | 2026-08-29 06:03:20.956286 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-29 06:03:21.499443 | noble -> localhost | changed 2026-08-29 06:03:21.515284 | 2026-08-29 06:03:21.515456 | TASK [add-build-sshkey : Add back temp key] 2026-08-29 06:03:21.877105 | noble -> localhost | Identity added: /var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/08a941d5219c43c5813575b4cb9aeebe_id_rsa (zuul-build-sshkey) 2026-08-29 06:03:21.877458 | noble -> localhost | ok: Runtime: 0:00:00.011058 2026-08-29 06:03:21.888455 | 2026-08-29 06:03:21.888612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-29 06:03:22.356994 | noble | ok 2026-08-29 06:03:22.365536 | 2026-08-29 06:03:22.365662 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-29 06:03:22.401393 | noble | skipping: Conditional result was False 2026-08-29 06:03:22.454340 | 2026-08-29 06:03:22.454482 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-29 06:03:22.924165 | noble | ok 2026-08-29 06:03:22.937316 | 2026-08-29 06:03:22.937461 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-29 06:03:22.970244 | noble | ok 2026-08-29 06:03:22.979120 | 2026-08-29 06:03:22.979244 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-29 06:03:23.297637 | noble -> localhost | ok 2026-08-29 06:03:23.314331 | 2026-08-29 06:03:23.314690 | TASK [validate-host : Collect information about the host] 2026-08-29 06:03:24.901008 | noble | ok 2026-08-29 06:03:24.924978 | 2026-08-29 06:03:24.925160 | TASK [validate-host : Sanitize hostname] 2026-08-29 06:03:25.009371 | noble | ok 2026-08-29 06:03:25.015600 | 2026-08-29 06:03:25.015717 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-29 06:03:25.651257 | noble -> localhost | changed 2026-08-29 06:03:25.658862 | 2026-08-29 06:03:25.659005 | TASK [validate-host : Collect information about zuul worker] 2026-08-29 06:03:26.166451 | noble | ok 2026-08-29 06:03:26.174675 | 2026-08-29 06:03:26.174950 | TASK [validate-host : Write out all zuul information for each host] 2026-08-29 06:03:26.738039 | noble -> localhost | changed 2026-08-29 06:03:26.755205 | 2026-08-29 06:03:26.755355 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-29 06:03:27.065815 | noble | ok 2026-08-29 06:03:27.072703 | 2026-08-29 06:03:27.072853 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-29 06:03:28.012966 | noble | changed: 2026-08-29 06:03:28.013212 | noble | cd+++++++++ src/ 2026-08-29 06:03:28.013247 | noble | cd+++++++++ src/github.com/ 2026-08-29 06:03:28.013271 | noble | cd+++++++++ src/github.com/osism/ 2026-08-29 06:03:28.013292 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-08-29 06:03:28.013312 | noble | localhost | ok: "/var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/logs" 2026-08-29 06:06:52.169368 | noble -> localhost | changed: "/var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/artifacts" 2026-08-29 06:06:52.450359 | noble -> localhost | changed: "/var/lib/zuul/builds/08a941d5219c43c5813575b4cb9aeebe/work/docs" 2026-08-29 06:06:52.481635 | 2026-08-29 06:06:52.482286 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-29 06:06:53.883191 | noble | changed: 2026-08-29 06:06:53.883616 | noble | .d..t...... ./ 2026-08-29 06:06:53.883679 | noble | >f+++++++++ net-debug.post.txt 2026-08-29 06:06:53.883719 | noble | >f+++++++++ net-debug.pre.txt 2026-08-29 06:06:53.883777 | noble | >f+++++++++ osism-esp.log 2026-08-29 06:06:53.883817 | noble | >f+++++++++ sudo-debug.txt 2026-08-29 06:06:53.883854 | noble | >f+++++++++ sudo-strace.log 2026-08-29 06:06:53.883893 | noble | >f+++++++++ sudo-strace.log.time 2026-08-29 06:06:53.883957 | noble | changed: All items complete 2026-08-29 06:06:53.883999 | 2026-08-29 06:06:54.600817 | noble | changed: .d..t...... ./ 2026-08-29 06:06:55.317945 | noble | changed: .d..t...... ./ 2026-08-29 06:06:55.347683 | 2026-08-29 06:06:55.347924 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-29 06:06:55.379582 | noble | skipping: Conditional result was False 2026-08-29 06:06:55.385932 | noble | skipping: Conditional result was False 2026-08-29 06:06:55.408532 | 2026-08-29 06:06:55.408649 | PLAY RECAP 2026-08-29 06:06:55.408745 | noble | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-29 06:06:55.408782 | 2026-08-29 06:06:55.569000 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-29 06:06:55.570095 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-29 06:06:56.329176 | 2026-08-29 06:06:56.329400 | PLAY [Base post] 2026-08-29 06:06:56.346054 | 2026-08-29 06:06:56.346233 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-29 06:06:57.037173 | noble | changed 2026-08-29 06:06:57.046805 | 2026-08-29 06:06:57.046962 | PLAY RECAP 2026-08-29 06:06:57.047038 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-29 06:06:57.047115 | 2026-08-29 06:06:57.178669 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-29 06:06:57.179790 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-29 06:06:58.018132 | 2026-08-29 06:06:58.018365 | PLAY [Base post-logs] 2026-08-29 06:06:58.031267 | 2026-08-29 06:06:58.031465 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-29 06:06:58.555893 | localhost | changed 2026-08-29 06:06:58.576527 | 2026-08-29 06:06:58.576800 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-29 06:06:58.616131 | localhost | ok 2026-08-29 06:06:58.622096 | 2026-08-29 06:06:58.622254 | TASK [Set zuul-log-path fact] 2026-08-29 06:06:58.639690 | localhost | ok 2026-08-29 06:06:58.651310 | 2026-08-29 06:06:58.651438 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-29 06:06:58.677316 | localhost | ok 2026-08-29 06:06:58.681399 | 2026-08-29 06:06:58.681548 | TASK [upload-logs : Create log directories] 2026-08-29 06:06:59.212247 | localhost | changed 2026-08-29 06:06:59.219224 | 2026-08-29 06:06:59.219389 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-29 06:06:59.746552 | localhost -> localhost | ok: Runtime: 0:00:00.008157 2026-08-29 06:06:59.759837 | 2026-08-29 06:06:59.760103 | TASK [upload-logs : Upload logs to log server] 2026-08-29 06:07:00.374455 | localhost | Output suppressed because no_log was given 2026-08-29 06:07:00.377468 | 2026-08-29 06:07:00.377604 | LOOP [upload-logs : Compress console log and json output] 2026-08-29 06:07:00.444066 | localhost | skipping: Conditional result was False 2026-08-29 06:07:00.449316 | localhost | skipping: Conditional result was False 2026-08-29 06:07:00.461352 | 2026-08-29 06:07:00.461613 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-29 06:07:00.532150 | localhost | skipping: Conditional result was False 2026-08-29 06:07:00.533021 | 2026-08-29 06:07:00.536711 | localhost | skipping: Conditional result was False 2026-08-29 06:07:00.549185 | 2026-08-29 06:07:00.549409 | LOOP [upload-logs : Upload console log and json output]