2026-09-12 06:02:59.124196 | Job console starting 2026-09-12 06:02:59.135098 | Updating git repos 2026-09-12 06:02:59.163732 | Cloning repos into workspace 2026-09-12 06:02:59.212440 | Restoring repo states 2026-09-12 06:02:59.225133 | Merging changes 2026-09-12 06:02:59.225152 | Checking out repos 2026-09-12 06:02:59.282356 | Preparing playbooks 2026-09-12 06:03:00.141222 | Running Ansible setup 2026-09-12 06:03:06.134550 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-12 06:03:06.884295 | 2026-09-12 06:03:06.884484 | PLAY [Base pre] 2026-09-12 06:03:06.907410 | 2026-09-12 06:03:06.907548 | TASK [Setup log path fact] 2026-09-12 06:03:06.937370 | noble | ok 2026-09-12 06:03:06.955394 | 2026-09-12 06:03:06.955543 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 06:03:06.985071 | noble | ok 2026-09-12 06:03:06.996794 | 2026-09-12 06:03:06.996935 | TASK [emit-job-header : Print job information] 2026-09-12 06:03:07.037593 | # Job Information 2026-09-12 06:03:07.037781 | Ansible Version: 2.16.14 2026-09-12 06:03:07.037816 | Job: openstack-ironic-images-publish-osism-ipa 2026-09-12 06:03:07.037861 | Pipeline: periodic-weekly 2026-09-12 06:03:07.037883 | Executor: 521e9411259a 2026-09-12 06:03:07.037904 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-09-12 06:03:07.037927 | Event ID: 772bebda7bf44ecaa474d1454fd8b691 2026-09-12 06:03:07.043616 | 2026-09-12 06:03:07.043740 | LOOP [emit-job-header : Print node information] 2026-09-12 06:03:07.155465 | noble | ok: 2026-09-12 06:03:07.155660 | noble | # Node Information 2026-09-12 06:03:07.155694 | noble | Inventory Hostname: noble 2026-09-12 06:03:07.155719 | noble | Hostname: ubuntu 2026-09-12 06:03:07.155741 | noble | Username: zuul 2026-09-12 06:03:07.155761 | noble | Distro: Ubuntu 24.04 2026-09-12 06:03:07.155785 | noble | Provider: regiocloud-a 2026-09-12 06:03:07.155806 | noble | Region: 2026-09-12 06:03:07.155827 | noble | Label: ubuntu-noble-uefi 2026-09-12 06:03:07.155861 | noble | Product Name: OpenStack Nova 2026-09-12 06:03:07.155881 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:26e2 2026-09-12 06:03:07.169533 | 2026-09-12 06:03:07.169702 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-12 06:03:07.684942 | noble -> localhost | changed 2026-09-12 06:03:07.699137 | 2026-09-12 06:03:07.699278 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-12 06:03:08.778351 | noble -> localhost | changed 2026-09-12 06:03:08.802026 | 2026-09-12 06:03:08.802187 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-12 06:03:09.250089 | noble -> localhost | ok 2026-09-12 06:03:09.257765 | 2026-09-12 06:03:09.257923 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-12 06:03:09.296996 | noble | ok 2026-09-12 06:03:09.316094 | noble | included: /var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-12 06:03:09.323126 | 2026-09-12 06:03:09.323226 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-12 06:03:10.323038 | noble -> localhost | Generating public/private rsa key pair. 2026-09-12 06:03:10.323224 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/8f12f29ce0da4f2697d512a9a8d4587a_id_rsa 2026-09-12 06:03:10.323260 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/8f12f29ce0da4f2697d512a9a8d4587a_id_rsa.pub 2026-09-12 06:03:10.323287 | noble -> localhost | The key fingerprint is: 2026-09-12 06:03:10.323311 | noble -> localhost | SHA256:g/1fTiS8cj4Xin/rkgGHbOAqVYMMNULE/4nLfbD6Zrc zuul-build-sshkey 2026-09-12 06:03:10.323334 | noble -> localhost | The key's randomart image is: 2026-09-12 06:03:10.323356 | noble -> localhost | +---[RSA 3072]----+ 2026-09-12 06:03:10.323377 | noble -> localhost | | +=+o. | 2026-09-12 06:03:10.323408 | noble -> localhost | | ..o.+ | 2026-09-12 06:03:10.323430 | noble -> localhost | | . o + . | 2026-09-12 06:03:10.323450 | noble -> localhost | | oo. =.. | 2026-09-12 06:03:10.323470 | noble -> localhost | | ..+So oo . | 2026-09-12 06:03:10.323497 | noble -> localhost | | . o +o .+. | 2026-09-12 06:03:10.323517 | noble -> localhost | | o o oo.o+o. | 2026-09-12 06:03:10.323538 | noble -> localhost | | o = +==+o | 2026-09-12 06:03:10.323559 | noble -> localhost | | .=.oEo+*+. | 2026-09-12 06:03:10.323579 | noble -> localhost | +----[SHA256]-----+ 2026-09-12 06:03:10.323633 | noble -> localhost | ok: Runtime: 0:00:00.528943 2026-09-12 06:03:10.330789 | 2026-09-12 06:03:10.330885 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-12 06:03:10.361234 | noble | ok 2026-09-12 06:03:10.369774 | noble | included: /var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-12 06:03:10.378613 | 2026-09-12 06:03:10.378685 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-12 06:03:10.390973 | noble | skipping: Conditional result was False 2026-09-12 06:03:10.396094 | 2026-09-12 06:03:10.396165 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-12 06:03:11.084153 | noble | changed 2026-09-12 06:03:11.091742 | 2026-09-12 06:03:11.091846 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-12 06:03:11.468295 | noble | ok 2026-09-12 06:03:11.479525 | 2026-09-12 06:03:11.479636 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-12 06:03:12.444710 | noble | changed 2026-09-12 06:03:12.453408 | 2026-09-12 06:03:12.453519 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-12 06:03:13.335491 | noble | changed 2026-09-12 06:03:13.346368 | 2026-09-12 06:03:13.346509 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-12 06:03:13.373206 | noble | skipping: Conditional result was False 2026-09-12 06:03:13.388500 | 2026-09-12 06:03:13.389799 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-12 06:03:13.792229 | noble -> localhost | changed 2026-09-12 06:03:13.812390 | 2026-09-12 06:03:13.812486 | TASK [add-build-sshkey : Add back temp key] 2026-09-12 06:03:14.108764 | noble -> localhost | Identity added: /var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/8f12f29ce0da4f2697d512a9a8d4587a_id_rsa (zuul-build-sshkey) 2026-09-12 06:03:14.109305 | noble -> localhost | ok: Runtime: 0:00:00.015130 2026-09-12 06:03:14.123798 | 2026-09-12 06:03:14.123960 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-12 06:03:14.598803 | noble | ok 2026-09-12 06:03:14.605969 | 2026-09-12 06:03:14.606061 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-12 06:03:14.638939 | noble | skipping: Conditional result was False 2026-09-12 06:03:14.684807 | 2026-09-12 06:03:14.684918 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-12 06:03:15.134477 | noble | ok 2026-09-12 06:03:15.145204 | 2026-09-12 06:03:15.145296 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-12 06:03:15.182131 | noble | ok 2026-09-12 06:03:15.199327 | 2026-09-12 06:03:15.199497 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-12 06:03:15.467288 | noble -> localhost | ok 2026-09-12 06:03:15.474318 | 2026-09-12 06:03:15.474403 | TASK [validate-host : Collect information about the host] 2026-09-12 06:03:16.937482 | noble | ok 2026-09-12 06:03:16.968192 | 2026-09-12 06:03:16.968322 | TASK [validate-host : Sanitize hostname] 2026-09-12 06:03:17.023094 | noble | ok 2026-09-12 06:03:17.030350 | 2026-09-12 06:03:17.030465 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-12 06:03:17.574699 | noble -> localhost | changed 2026-09-12 06:03:17.587693 | 2026-09-12 06:03:17.587899 | TASK [validate-host : Collect information about zuul worker] 2026-09-12 06:03:18.166760 | noble | ok 2026-09-12 06:03:18.172937 | 2026-09-12 06:03:18.173063 | TASK [validate-host : Write out all zuul information for each host] 2026-09-12 06:03:18.760076 | noble -> localhost | changed 2026-09-12 06:03:18.771644 | 2026-09-12 06:03:18.771758 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-12 06:03:19.165206 | noble | ok 2026-09-12 06:03:19.171454 | 2026-09-12 06:03:19.171562 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-12 06:03:20.000097 | noble | changed: 2026-09-12 06:03:20.000301 | noble | cd+++++++++ src/ 2026-09-12 06:03:20.000338 | noble | cd+++++++++ src/github.com/ 2026-09-12 06:03:20.000363 | noble | cd+++++++++ src/github.com/osism/ 2026-09-12 06:03:20.000454 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-09-12 06:03:20.000477 | noble | localhost | ok: "/var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/logs" 2026-09-12 06:10:58.267617 | noble -> localhost | changed: "/var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/artifacts" 2026-09-12 06:10:58.537305 | noble -> localhost | changed: "/var/lib/zuul/builds/8f12f29ce0da4f2697d512a9a8d4587a/work/docs" 2026-09-12 06:10:58.558298 | 2026-09-12 06:10:58.558543 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-12 06:10:59.913341 | noble | changed: 2026-09-12 06:10:59.913748 | noble | .d..t...... ./ 2026-09-12 06:10:59.913814 | noble | >f+++++++++ net-debug.post.txt 2026-09-12 06:10:59.913854 | noble | >f+++++++++ net-debug.pre.txt 2026-09-12 06:10:59.913890 | noble | >f+++++++++ osism-ipa.log 2026-09-12 06:10:59.913925 | noble | >f+++++++++ sudo-debug.txt 2026-09-12 06:10:59.913982 | noble | >f+++++++++ sudo-strace.log 2026-09-12 06:10:59.914014 | noble | >f+++++++++ sudo-strace.log.time 2026-09-12 06:10:59.914074 | noble | changed: All items complete 2026-09-12 06:10:59.914116 | 2026-09-12 06:11:00.544006 | noble | changed: .d..t...... ./ 2026-09-12 06:11:01.194132 | noble | changed: .d..t...... ./ 2026-09-12 06:11:01.228054 | 2026-09-12 06:11:01.228206 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-12 06:11:01.263969 | noble | skipping: Conditional result was False 2026-09-12 06:11:01.266764 | noble | skipping: Conditional result was False 2026-09-12 06:11:01.289461 | 2026-09-12 06:11:01.289598 | PLAY RECAP 2026-09-12 06:11:01.289678 | noble | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-12 06:11:01.289722 | 2026-09-12 06:11:01.412635 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-12 06:11:01.413826 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 06:11:02.137332 | 2026-09-12 06:11:02.137491 | PLAY [Base post] 2026-09-12 06:11:02.152031 | 2026-09-12 06:11:02.152159 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-12 06:11:02.868227 | noble | changed 2026-09-12 06:11:02.878133 | 2026-09-12 06:11:02.878257 | PLAY RECAP 2026-09-12 06:11:02.878335 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 06:11:02.878408 | 2026-09-12 06:11:02.992240 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 06:11:02.993625 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-12 06:11:03.771549 | 2026-09-12 06:11:03.771705 | PLAY [Base post-logs] 2026-09-12 06:11:03.782482 | 2026-09-12 06:11:03.782617 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-12 06:11:04.226690 | localhost | changed 2026-09-12 06:11:04.243438 | 2026-09-12 06:11:04.243601 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-12 06:11:04.271902 | localhost | ok 2026-09-12 06:11:04.279427 | 2026-09-12 06:11:04.279606 | TASK [Set zuul-log-path fact] 2026-09-12 06:11:04.308467 | localhost | ok 2026-09-12 06:11:04.322455 | 2026-09-12 06:11:04.322590 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 06:11:04.359008 | localhost | ok 2026-09-12 06:11:04.364326 | 2026-09-12 06:11:04.364477 | TASK [upload-logs : Create log directories] 2026-09-12 06:11:04.848597 | localhost | changed 2026-09-12 06:11:04.854247 | 2026-09-12 06:11:04.854407 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-12 06:11:05.341477 | localhost -> localhost | ok: Runtime: 0:00:00.006403 2026-09-12 06:11:05.345669 | 2026-09-12 06:11:05.345786 | TASK [upload-logs : Upload logs to log server] 2026-09-12 06:11:05.893627 | localhost | Output suppressed because no_log was given 2026-09-12 06:11:05.895459 | 2026-09-12 06:11:05.895560 | LOOP [upload-logs : Compress console log and json output] 2026-09-12 06:11:05.948753 | localhost | skipping: Conditional result was False 2026-09-12 06:11:05.953095 | localhost | skipping: Conditional result was False 2026-09-12 06:11:05.965744 | 2026-09-12 06:11:05.966042 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-12 06:11:06.023252 | localhost | skipping: Conditional result was False 2026-09-12 06:11:06.023573 | 2026-09-12 06:11:06.027166 | localhost | skipping: Conditional result was False 2026-09-12 06:11:06.040215 | 2026-09-12 06:11:06.040444 | LOOP [upload-logs : Upload console log and json output]