2026-08-15 06:02:58.711903 | Job console starting 2026-08-15 06:02:58.750215 | Updating git repos 2026-08-15 06:02:58.786893 | Cloning repos into workspace 2026-08-15 06:02:58.825956 | Restoring repo states 2026-08-15 06:02:58.833927 | Merging changes 2026-08-15 06:02:58.833946 | Checking out repos 2026-08-15 06:02:58.884544 | Preparing playbooks 2026-08-15 06:02:59.790396 | Running Ansible setup 2026-08-15 06:03:05.785750 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-15 06:03:06.821374 | 2026-08-15 06:03:06.821572 | PLAY [Base pre] 2026-08-15 06:03:06.842624 | 2026-08-15 06:03:06.842784 | TASK [Setup log path fact] 2026-08-15 06:03:06.876606 | noble | ok 2026-08-15 06:03:06.896891 | 2026-08-15 06:03:06.897069 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-15 06:03:06.927442 | noble | ok 2026-08-15 06:03:06.939688 | 2026-08-15 06:03:06.939826 | TASK [emit-job-header : Print job information] 2026-08-15 06:03:06.981772 | # Job Information 2026-08-15 06:03:06.981996 | Ansible Version: 2.16.14 2026-08-15 06:03:06.982032 | Job: openstack-ironic-images-publish-osism-node 2026-08-15 06:03:06.982066 | Pipeline: periodic-weekly 2026-08-15 06:03:06.982089 | Executor: 521e9411259a 2026-08-15 06:03:06.982110 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-08-15 06:03:06.982131 | Event ID: 88986b33c225486b81a7a29de3f5c12d 2026-08-15 06:03:06.996686 | 2026-08-15 06:03:06.996825 | LOOP [emit-job-header : Print node information] 2026-08-15 06:03:07.133364 | noble | ok: 2026-08-15 06:03:07.133596 | noble | # Node Information 2026-08-15 06:03:07.133630 | noble | Inventory Hostname: noble 2026-08-15 06:03:07.133656 | noble | Hostname: ubuntu 2026-08-15 06:03:07.133679 | noble | Username: zuul 2026-08-15 06:03:07.133700 | noble | Distro: Ubuntu 24.04 2026-08-15 06:03:07.133724 | noble | Provider: regiocloud-a 2026-08-15 06:03:07.133745 | noble | Region: 2026-08-15 06:03:07.133767 | noble | Label: ubuntu-noble-uefi 2026-08-15 06:03:07.133787 | noble | Product Name: OpenStack Nova 2026-08-15 06:03:07.133807 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7c:10cf 2026-08-15 06:03:07.166771 | 2026-08-15 06:03:07.166975 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-15 06:03:07.800548 | noble -> localhost | changed 2026-08-15 06:03:07.824375 | 2026-08-15 06:03:07.824580 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-15 06:03:09.147762 | noble -> localhost | changed 2026-08-15 06:03:09.161745 | 2026-08-15 06:03:09.161897 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-15 06:03:09.479772 | noble -> localhost | ok 2026-08-15 06:03:09.487747 | 2026-08-15 06:03:09.487889 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-15 06:03:09.517758 | noble | ok 2026-08-15 06:03:09.539681 | noble | included: /var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-15 06:03:09.548554 | 2026-08-15 06:03:09.548689 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-15 06:03:10.479372 | noble -> localhost | Generating public/private rsa key pair. 2026-08-15 06:03:10.479659 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/ce3d8524deba43769ad72560ab9b94d4_id_rsa 2026-08-15 06:03:10.479700 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/ce3d8524deba43769ad72560ab9b94d4_id_rsa.pub 2026-08-15 06:03:10.479727 | noble -> localhost | The key fingerprint is: 2026-08-15 06:03:10.479752 | noble -> localhost | SHA256:/mPfvUNp6NSA1rsGmB/lCatoMZ4KWDr7peOlJaMdxL0 zuul-build-sshkey 2026-08-15 06:03:10.479774 | noble -> localhost | The key's randomart image is: 2026-08-15 06:03:10.479795 | noble -> localhost | +---[RSA 3072]----+ 2026-08-15 06:03:10.479816 | noble -> localhost | | | 2026-08-15 06:03:10.479851 | noble -> localhost | | | 2026-08-15 06:03:10.479872 | noble -> localhost | | o | 2026-08-15 06:03:10.479891 | noble -> localhost | | . . + + | 2026-08-15 06:03:10.479910 | noble -> localhost | | + . S + = * .| 2026-08-15 06:03:10.479934 | noble -> localhost | | = .+ o + * = | 2026-08-15 06:03:10.479956 | noble -> localhost | | + = E. * o = + | 2026-08-15 06:03:10.479976 | noble -> localhost | | =.@ = oo. = o | 2026-08-15 06:03:10.479997 | noble -> localhost | | oo*..o ..oo ..+| 2026-08-15 06:03:10.480017 | noble -> localhost | +----[SHA256]-----+ 2026-08-15 06:03:10.480076 | noble -> localhost | ok: Runtime: 0:00:00.348005 2026-08-15 06:03:10.496292 | 2026-08-15 06:03:10.496458 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-15 06:03:10.527414 | noble | ok 2026-08-15 06:03:10.540079 | noble | included: /var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-15 06:03:10.552367 | 2026-08-15 06:03:10.553056 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-15 06:03:10.578428 | noble | skipping: Conditional result was False 2026-08-15 06:03:10.586178 | 2026-08-15 06:03:10.586323 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-15 06:03:11.289932 | noble | changed 2026-08-15 06:03:11.305643 | 2026-08-15 06:03:11.305800 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-15 06:03:11.601597 | noble | ok 2026-08-15 06:03:11.613462 | 2026-08-15 06:03:11.613633 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-15 06:03:12.423579 | noble | changed 2026-08-15 06:03:12.430388 | 2026-08-15 06:03:12.430515 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-15 06:03:13.214072 | noble | changed 2026-08-15 06:03:13.225560 | 2026-08-15 06:03:13.225705 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-15 06:03:13.283170 | noble | skipping: Conditional result was False 2026-08-15 06:03:13.292234 | 2026-08-15 06:03:13.292394 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-15 06:03:13.809972 | noble -> localhost | changed 2026-08-15 06:03:13.825172 | 2026-08-15 06:03:13.825326 | TASK [add-build-sshkey : Add back temp key] 2026-08-15 06:03:14.195378 | noble -> localhost | Identity added: /var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/ce3d8524deba43769ad72560ab9b94d4_id_rsa (zuul-build-sshkey) 2026-08-15 06:03:14.195671 | noble -> localhost | ok: Runtime: 0:00:00.012778 2026-08-15 06:03:14.207225 | 2026-08-15 06:03:14.207375 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-15 06:03:14.663325 | noble | ok 2026-08-15 06:03:14.674528 | 2026-08-15 06:03:14.674705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-15 06:03:14.709599 | noble | skipping: Conditional result was False 2026-08-15 06:03:14.774601 | 2026-08-15 06:03:14.774755 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-15 06:03:15.224373 | noble | ok 2026-08-15 06:03:15.236322 | 2026-08-15 06:03:15.236460 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-15 06:03:15.269271 | noble | ok 2026-08-15 06:03:15.276502 | 2026-08-15 06:03:15.276632 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-15 06:03:15.565078 | noble -> localhost | ok 2026-08-15 06:03:15.573311 | 2026-08-15 06:03:15.573453 | TASK [validate-host : Collect information about the host] 2026-08-15 06:03:17.018422 | noble | ok 2026-08-15 06:03:17.035837 | 2026-08-15 06:03:17.035983 | TASK [validate-host : Sanitize hostname] 2026-08-15 06:03:17.096326 | noble | ok 2026-08-15 06:03:17.102538 | 2026-08-15 06:03:17.102665 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-15 06:03:17.879580 | noble -> localhost | changed 2026-08-15 06:03:17.888508 | 2026-08-15 06:03:17.888660 | TASK [validate-host : Collect information about zuul worker] 2026-08-15 06:03:18.465580 | noble | ok 2026-08-15 06:03:18.475598 | 2026-08-15 06:03:18.475778 | TASK [validate-host : Write out all zuul information for each host] 2026-08-15 06:03:19.059334 | noble -> localhost | changed 2026-08-15 06:03:19.070947 | 2026-08-15 06:03:19.071092 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-15 06:03:19.376038 | noble | ok 2026-08-15 06:03:19.391248 | 2026-08-15 06:03:19.391409 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-15 06:03:20.411713 | noble | changed: 2026-08-15 06:03:20.412043 | noble | cd+++++++++ src/ 2026-08-15 06:03:20.412101 | noble | cd+++++++++ src/github.com/ 2026-08-15 06:03:20.412200 | noble | cd+++++++++ src/github.com/osism/ 2026-08-15 06:03:20.412240 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-08-15 06:03:20.412274 | noble | localhost | ok: "/var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/logs" 2026-08-15 06:18:53.537845 | noble -> localhost | changed: "/var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/artifacts" 2026-08-15 06:18:53.829848 | noble -> localhost | changed: "/var/lib/zuul/builds/ce3d8524deba43769ad72560ab9b94d4/work/docs" 2026-08-15 06:18:53.857258 | 2026-08-15 06:18:53.857461 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-15 06:18:55.167074 | noble | changed: 2026-08-15 06:18:55.167557 | noble | .d..t...... ./ 2026-08-15 06:18:55.167657 | noble | >f+++++++++ net-debug.post.txt 2026-08-15 06:18:55.167760 | noble | >f+++++++++ net-debug.pre.txt 2026-08-15 06:18:55.167846 | noble | >f+++++++++ osism-node.log 2026-08-15 06:18:55.167912 | noble | >f+++++++++ sudo-debug.txt 2026-08-15 06:18:55.168203 | noble | >f+++++++++ sudo-strace.log 2026-08-15 06:18:55.168453 | noble | >f+++++++++ sudo-strace.log.time 2026-08-15 06:18:55.168628 | noble | changed: All items complete 2026-08-15 06:18:55.168715 | 2026-08-15 06:18:55.862803 | noble | changed: .d..t...... ./ 2026-08-15 06:18:56.546794 | noble | changed: .d..t...... ./ 2026-08-15 06:18:56.576437 | 2026-08-15 06:18:56.576615 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-15 06:18:56.616512 | noble | skipping: Conditional result was False 2026-08-15 06:18:56.619127 | noble | skipping: Conditional result was False 2026-08-15 06:18:56.630879 | 2026-08-15 06:18:56.630980 | PLAY RECAP 2026-08-15 06:18:56.631044 | noble | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-15 06:18:56.631075 | 2026-08-15 06:18:56.792659 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-15 06:18:56.793739 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-15 06:18:57.518401 | 2026-08-15 06:18:57.518577 | PLAY [Base post] 2026-08-15 06:18:57.533641 | 2026-08-15 06:18:57.533830 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-15 06:18:58.172539 | noble | changed 2026-08-15 06:18:58.183178 | 2026-08-15 06:18:58.183332 | PLAY RECAP 2026-08-15 06:18:58.183405 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-15 06:18:58.183473 | 2026-08-15 06:18:58.319616 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-15 06:18:58.322781 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-15 06:18:59.133782 | 2026-08-15 06:18:59.133984 | PLAY [Base post-logs] 2026-08-15 06:18:59.145771 | 2026-08-15 06:18:59.145929 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-15 06:18:59.639496 | localhost | changed 2026-08-15 06:18:59.650545 | 2026-08-15 06:18:59.650776 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-15 06:18:59.687284 | localhost | ok 2026-08-15 06:18:59.690565 | 2026-08-15 06:18:59.690671 | TASK [Set zuul-log-path fact] 2026-08-15 06:18:59.706034 | localhost | ok 2026-08-15 06:18:59.714264 | 2026-08-15 06:18:59.714379 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-15 06:18:59.740238 | localhost | ok 2026-08-15 06:18:59.744523 | 2026-08-15 06:18:59.744650 | TASK [upload-logs : Create log directories] 2026-08-15 06:19:00.318503 | localhost | changed 2026-08-15 06:19:00.323388 | 2026-08-15 06:19:00.323553 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-15 06:19:00.831162 | localhost -> localhost | ok: Runtime: 0:00:00.007537 2026-08-15 06:19:00.840515 | 2026-08-15 06:19:00.840712 | TASK [upload-logs : Upload logs to log server] 2026-08-15 06:19:01.490256 | localhost | Output suppressed because no_log was given 2026-08-15 06:19:01.493901 | 2026-08-15 06:19:01.494072 | LOOP [upload-logs : Compress console log and json output] 2026-08-15 06:19:01.552225 | localhost | skipping: Conditional result was False 2026-08-15 06:19:01.556876 | localhost | skipping: Conditional result was False 2026-08-15 06:19:01.570716 | 2026-08-15 06:19:01.570996 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-15 06:19:01.621711 | localhost | skipping: Conditional result was False 2026-08-15 06:19:01.622432 | 2026-08-15 06:19:01.625113 | localhost | skipping: Conditional result was False 2026-08-15 06:19:01.633929 | 2026-08-15 06:19:01.634173 | LOOP [upload-logs : Upload console log and json output]