2026-09-05 06:03:03.001730 | Job console starting 2026-09-05 06:03:03.014360 | Updating git repos 2026-09-05 06:03:03.044026 | Cloning repos into workspace 2026-09-05 06:03:03.087149 | Restoring repo states 2026-09-05 06:03:03.092547 | Merging changes 2026-09-05 06:03:03.092565 | Checking out repos 2026-09-05 06:03:03.136646 | Preparing playbooks 2026-09-05 06:03:03.915484 | Running Ansible setup 2026-09-05 06:03:10.327269 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-05 06:03:11.122140 | 2026-09-05 06:03:11.122308 | PLAY [Base pre] 2026-09-05 06:03:11.143170 | 2026-09-05 06:03:11.143346 | TASK [Setup log path fact] 2026-09-05 06:03:11.163570 | noble | ok 2026-09-05 06:03:11.184469 | 2026-09-05 06:03:11.184639 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 06:03:11.229134 | noble | ok 2026-09-05 06:03:11.241302 | 2026-09-05 06:03:11.241483 | TASK [emit-job-header : Print job information] 2026-09-05 06:03:11.282801 | # Job Information 2026-09-05 06:03:11.283026 | Ansible Version: 2.16.14 2026-09-05 06:03:11.283065 | Job: openstack-ironic-images-publish-osism-esp 2026-09-05 06:03:11.283099 | Pipeline: periodic-weekly 2026-09-05 06:03:11.283123 | Executor: 521e9411259a 2026-09-05 06:03:11.283145 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-09-05 06:03:11.283169 | Event ID: 28c2609cad6a413283dba49df46f9a50 2026-09-05 06:03:11.290912 | 2026-09-05 06:03:11.291048 | LOOP [emit-job-header : Print node information] 2026-09-05 06:03:11.407224 | noble | ok: 2026-09-05 06:03:11.407432 | noble | # Node Information 2026-09-05 06:03:11.407467 | noble | Inventory Hostname: noble 2026-09-05 06:03:11.407494 | noble | Hostname: ubuntu 2026-09-05 06:03:11.407517 | noble | Username: zuul 2026-09-05 06:03:11.407538 | noble | Distro: Ubuntu 24.04 2026-09-05 06:03:11.407561 | noble | Provider: regiocloud-a 2026-09-05 06:03:11.407583 | noble | Region: 2026-09-05 06:03:11.407606 | noble | Label: ubuntu-noble-uefi 2026-09-05 06:03:11.407627 | noble | Product Name: OpenStack Nova 2026-09-05 06:03:11.407647 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefe:6224 2026-09-05 06:03:11.420759 | 2026-09-05 06:03:11.420897 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-05 06:03:11.914675 | noble -> localhost | changed 2026-09-05 06:03:11.928042 | 2026-09-05 06:03:11.928190 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-05 06:03:13.023987 | noble -> localhost | changed 2026-09-05 06:03:13.037369 | 2026-09-05 06:03:13.037478 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-05 06:03:13.312958 | noble -> localhost | ok 2026-09-05 06:03:13.319682 | 2026-09-05 06:03:13.319782 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-05 06:03:13.339167 | noble | ok 2026-09-05 06:03:13.357766 | noble | included: /var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-05 06:03:13.364873 | 2026-09-05 06:03:13.364956 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-05 06:03:14.110809 | noble -> localhost | Generating public/private rsa key pair. 2026-09-05 06:03:14.110994 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/e6258fdf219f4d2aac5a09c245815044_id_rsa 2026-09-05 06:03:14.111031 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/e6258fdf219f4d2aac5a09c245815044_id_rsa.pub 2026-09-05 06:03:14.111057 | noble -> localhost | The key fingerprint is: 2026-09-05 06:03:14.111082 | noble -> localhost | SHA256:yx8/uUyWaaCD4QLxwPzuLkIDugo9PcZDnXfJ7uMtH3M zuul-build-sshkey 2026-09-05 06:03:14.111104 | noble -> localhost | The key's randomart image is: 2026-09-05 06:03:14.111125 | noble -> localhost | +---[RSA 3072]----+ 2026-09-05 06:03:14.111146 | noble -> localhost | | | 2026-09-05 06:03:14.111178 | noble -> localhost | | o | 2026-09-05 06:03:14.111199 | noble -> localhost | | = | 2026-09-05 06:03:14.111218 | noble -> localhost | |. = . . . . | 2026-09-05 06:03:14.111238 | noble -> localhost | |o . + + S = | 2026-09-05 06:03:14.111262 | noble -> localhost | |.+ * . = = . o | 2026-09-05 06:03:14.111282 | noble -> localhost | |o.+ O o = o O.E | 2026-09-05 06:03:14.111302 | noble -> localhost | |+ .+ + +oOo+ | 2026-09-05 06:03:14.111333 | noble -> localhost | |o. oo .++*o | 2026-09-05 06:03:14.111356 | noble -> localhost | +----[SHA256]-----+ 2026-09-05 06:03:14.111400 | noble -> localhost | ok: Runtime: 0:00:00.351346 2026-09-05 06:03:14.118512 | 2026-09-05 06:03:14.118603 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-05 06:03:14.137011 | noble | ok 2026-09-05 06:03:14.147137 | noble | included: /var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-05 06:03:14.156952 | 2026-09-05 06:03:14.157032 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-05 06:03:14.179685 | noble | skipping: Conditional result was False 2026-09-05 06:03:14.186219 | 2026-09-05 06:03:14.186305 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-05 06:03:14.870172 | noble | changed 2026-09-05 06:03:14.876213 | 2026-09-05 06:03:14.876298 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-05 06:03:15.217259 | noble | ok 2026-09-05 06:03:15.230157 | 2026-09-05 06:03:15.230246 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-05 06:03:16.046507 | noble | changed 2026-09-05 06:03:16.054729 | 2026-09-05 06:03:16.054857 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-05 06:03:16.859712 | noble | changed 2026-09-05 06:03:16.865973 | 2026-09-05 06:03:16.866058 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-05 06:03:16.879847 | noble | skipping: Conditional result was False 2026-09-05 06:03:16.888821 | 2026-09-05 06:03:16.888916 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-05 06:03:17.266305 | noble -> localhost | changed 2026-09-05 06:03:17.287638 | 2026-09-05 06:03:17.287731 | TASK [add-build-sshkey : Add back temp key] 2026-09-05 06:03:17.593703 | noble -> localhost | Identity added: /var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/e6258fdf219f4d2aac5a09c245815044_id_rsa (zuul-build-sshkey) 2026-09-05 06:03:17.594132 | noble -> localhost | ok: Runtime: 0:00:00.016138 2026-09-05 06:03:17.605703 | 2026-09-05 06:03:17.605820 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-05 06:03:18.066254 | noble | ok 2026-09-05 06:03:18.078006 | 2026-09-05 06:03:18.078109 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-05 06:03:18.111402 | noble | skipping: Conditional result was False 2026-09-05 06:03:18.153858 | 2026-09-05 06:03:18.153957 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-05 06:03:18.607178 | noble | ok 2026-09-05 06:03:18.617811 | 2026-09-05 06:03:18.617906 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-05 06:03:18.647356 | noble | ok 2026-09-05 06:03:18.653065 | 2026-09-05 06:03:18.653155 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-05 06:03:18.878653 | noble -> localhost | ok 2026-09-05 06:03:18.885685 | 2026-09-05 06:03:18.885770 | TASK [validate-host : Collect information about the host] 2026-09-05 06:03:20.312978 | noble | ok 2026-09-05 06:03:20.331210 | 2026-09-05 06:03:20.331311 | TASK [validate-host : Sanitize hostname] 2026-09-05 06:03:20.389810 | noble | ok 2026-09-05 06:03:20.394888 | 2026-09-05 06:03:20.394974 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-05 06:03:20.812536 | noble -> localhost | changed 2026-09-05 06:03:20.818819 | 2026-09-05 06:03:20.818923 | TASK [validate-host : Collect information about zuul worker] 2026-09-05 06:03:21.318964 | noble | ok 2026-09-05 06:03:21.327462 | 2026-09-05 06:03:21.327585 | TASK [validate-host : Write out all zuul information for each host] 2026-09-05 06:03:21.838619 | noble -> localhost | changed 2026-09-05 06:03:21.858822 | 2026-09-05 06:03:21.859010 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-05 06:03:22.192238 | noble | ok 2026-09-05 06:03:22.199198 | 2026-09-05 06:03:22.199290 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-05 06:03:23.245057 | noble | changed: 2026-09-05 06:03:23.245212 | noble | cd+++++++++ src/ 2026-09-05 06:03:23.245245 | noble | cd+++++++++ src/github.com/ 2026-09-05 06:03:23.245269 | noble | cd+++++++++ src/github.com/osism/ 2026-09-05 06:03:23.245289 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-09-05 06:03:23.245309 | noble | localhost | ok: "/var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/logs" 2026-09-05 06:07:23.848354 | noble -> localhost | changed: "/var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/artifacts" 2026-09-05 06:07:24.133630 | noble -> localhost | changed: "/var/lib/zuul/builds/e6258fdf219f4d2aac5a09c245815044/work/docs" 2026-09-05 06:07:24.162173 | 2026-09-05 06:07:24.162327 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-05 06:07:25.521321 | noble | changed: 2026-09-05 06:07:25.521641 | noble | .d..t...... ./ 2026-09-05 06:07:25.521687 | noble | >f+++++++++ net-debug.post.txt 2026-09-05 06:07:25.521716 | noble | >f+++++++++ net-debug.pre.txt 2026-09-05 06:07:25.521742 | noble | >f+++++++++ osism-esp.log 2026-09-05 06:07:25.521767 | noble | >f+++++++++ sudo-debug.txt 2026-09-05 06:07:25.521792 | noble | >f+++++++++ sudo-strace.log 2026-09-05 06:07:25.521821 | noble | >f+++++++++ sudo-strace.log.time 2026-09-05 06:07:25.521875 | noble | changed: All items complete 2026-09-05 06:07:25.521907 | 2026-09-05 06:07:26.204472 | noble | changed: .d..t...... ./ 2026-09-05 06:07:26.864273 | noble | changed: .d..t...... ./ 2026-09-05 06:07:26.885643 | 2026-09-05 06:07:26.885867 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-05 06:07:26.910986 | noble | skipping: Conditional result was False 2026-09-05 06:07:26.913927 | noble | skipping: Conditional result was False 2026-09-05 06:07:26.934540 | 2026-09-05 06:07:26.934646 | PLAY RECAP 2026-09-05 06:07:26.934717 | noble | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-05 06:07:26.934750 | 2026-09-05 06:07:27.059917 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-05 06:07:27.060895 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 06:07:27.788361 | 2026-09-05 06:07:27.788547 | PLAY [Base post] 2026-09-05 06:07:27.803086 | 2026-09-05 06:07:27.803209 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-05 06:07:28.451288 | noble | changed 2026-09-05 06:07:28.459481 | 2026-09-05 06:07:28.459593 | PLAY RECAP 2026-09-05 06:07:28.459656 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-05 06:07:28.459719 | 2026-09-05 06:07:28.578310 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 06:07:28.580591 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-05 06:07:29.359177 | 2026-09-05 06:07:29.359338 | PLAY [Base post-logs] 2026-09-05 06:07:29.370210 | 2026-09-05 06:07:29.370348 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-05 06:07:29.835725 | localhost | changed 2026-09-05 06:07:29.850792 | 2026-09-05 06:07:29.851083 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-05 06:07:29.879035 | localhost | ok 2026-09-05 06:07:29.884289 | 2026-09-05 06:07:29.884509 | TASK [Set zuul-log-path fact] 2026-09-05 06:07:29.901241 | localhost | ok 2026-09-05 06:07:29.911330 | 2026-09-05 06:07:29.911458 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 06:07:29.936945 | localhost | ok 2026-09-05 06:07:29.941879 | 2026-09-05 06:07:29.942009 | TASK [upload-logs : Create log directories] 2026-09-05 06:07:30.440257 | localhost | changed 2026-09-05 06:07:30.445406 | 2026-09-05 06:07:30.445567 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-05 06:07:30.928595 | localhost -> localhost | ok: Runtime: 0:00:00.006553 2026-09-05 06:07:30.937191 | 2026-09-05 06:07:30.937446 | TASK [upload-logs : Upload logs to log server] 2026-09-05 06:07:31.484678 | localhost | Output suppressed because no_log was given 2026-09-05 06:07:31.488791 | 2026-09-05 06:07:31.488978 | LOOP [upload-logs : Compress console log and json output] 2026-09-05 06:07:31.545561 | localhost | skipping: Conditional result was False 2026-09-05 06:07:31.550346 | localhost | skipping: Conditional result was False 2026-09-05 06:07:31.563793 | 2026-09-05 06:07:31.564033 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-05 06:07:31.611218 | localhost | skipping: Conditional result was False 2026-09-05 06:07:31.611878 | 2026-09-05 06:07:31.615226 | localhost | skipping: Conditional result was False 2026-09-05 06:07:31.629042 | 2026-09-05 06:07:31.629238 | LOOP [upload-logs : Upload console log and json output]