2026-04-25 06:02:59.793939 | Job console starting 2026-04-25 06:02:59.803062 | Updating git repos 2026-04-25 06:02:59.828808 | Cloning repos into workspace 2026-04-25 06:02:59.936835 | Restoring repo states 2026-04-25 06:02:59.945272 | Merging changes 2026-04-25 06:02:59.945295 | Checking out repos 2026-04-25 06:03:00.003938 | Preparing playbooks 2026-04-25 06:03:00.765595 | Running Ansible setup 2026-04-25 06:03:06.756411 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-25 06:03:07.489054 | 2026-04-25 06:03:07.489226 | PLAY [Base pre] 2026-04-25 06:03:07.514876 | 2026-04-25 06:03:07.515046 | TASK [Setup log path fact] 2026-04-25 06:03:07.546772 | noble | ok 2026-04-25 06:03:07.568482 | 2026-04-25 06:03:07.568699 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-25 06:03:07.598730 | noble | ok 2026-04-25 06:03:07.610761 | 2026-04-25 06:03:07.611078 | TASK [emit-job-header : Print job information] 2026-04-25 06:03:07.671461 | # Job Information 2026-04-25 06:03:07.671674 | Ansible Version: 2.16.14 2026-04-25 06:03:07.671710 | Job: openstack-ironic-images-publish-osism-ipa 2026-04-25 06:03:07.671742 | Pipeline: periodic-weekly 2026-04-25 06:03:07.671765 | Executor: 521e9411259a 2026-04-25 06:03:07.671785 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-04-25 06:03:07.671808 | Event ID: 325f4aa841b5457f922045b12af94c86 2026-04-25 06:03:07.678966 | 2026-04-25 06:03:07.679100 | LOOP [emit-job-header : Print node information] 2026-04-25 06:03:07.870278 | noble | ok: 2026-04-25 06:03:07.870469 | noble | # Node Information 2026-04-25 06:03:07.870523 | noble | Inventory Hostname: noble 2026-04-25 06:03:07.870550 | noble | Hostname: ubuntu 2026-04-25 06:03:07.870571 | noble | Username: zuul 2026-04-25 06:03:07.870592 | noble | Distro: Ubuntu 24.04 2026-04-25 06:03:07.870616 | noble | Provider: regiocloud-a 2026-04-25 06:03:07.870636 | noble | Region: 2026-04-25 06:03:07.870659 | noble | Label: ubuntu-noble-uefi 2026-04-25 06:03:07.870680 | noble | Product Name: OpenStack Nova 2026-04-25 06:03:07.870702 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6e:4cfd 2026-04-25 06:03:07.889729 | 2026-04-25 06:03:07.889866 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-25 06:03:08.420068 | noble -> localhost | changed 2026-04-25 06:03:08.428383 | 2026-04-25 06:03:08.428551 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-25 06:03:09.678372 | noble -> localhost | changed 2026-04-25 06:03:09.693547 | 2026-04-25 06:03:09.693696 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-25 06:03:09.981367 | noble -> localhost | ok 2026-04-25 06:03:09.988712 | 2026-04-25 06:03:09.988840 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-25 06:03:10.018446 | noble | ok 2026-04-25 06:03:10.035427 | noble | included: /var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-25 06:03:10.044227 | 2026-04-25 06:03:10.044354 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-25 06:03:11.609191 | noble -> localhost | Generating public/private rsa key pair. 2026-04-25 06:03:11.609634 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/7b237830b39d43989a0f85a65b210ff6_id_rsa 2026-04-25 06:03:11.609723 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/7b237830b39d43989a0f85a65b210ff6_id_rsa.pub 2026-04-25 06:03:11.609782 | noble -> localhost | The key fingerprint is: 2026-04-25 06:03:11.609839 | noble -> localhost | SHA256:/dMw7NayCJZ74aOICSL103kbSduXUgcSuaIAyvH2F8k zuul-build-sshkey 2026-04-25 06:03:11.609887 | noble -> localhost | The key's randomart image is: 2026-04-25 06:03:11.609931 | noble -> localhost | +---[RSA 3072]----+ 2026-04-25 06:03:11.609973 | noble -> localhost | | .. | 2026-04-25 06:03:11.610031 | noble -> localhost | | .. .. | 2026-04-25 06:03:11.610077 | noble -> localhost | |..o. . . ... | 2026-04-25 06:03:11.610119 | noble -> localhost | |.. o. E...o . | 2026-04-25 06:03:11.610161 | noble -> localhost | | o .. .S.. = . | 2026-04-25 06:03:11.610217 | noble -> localhost | | . . o.+ =.+ B | 2026-04-25 06:03:11.610260 | noble -> localhost | |o . o + O.o.O o | 2026-04-25 06:03:11.610299 | noble -> localhost | |.. . + + =+= + | 2026-04-25 06:03:11.610342 | noble -> localhost | | o . +o... | 2026-04-25 06:03:11.610383 | noble -> localhost | +----[SHA256]-----+ 2026-04-25 06:03:11.610477 | noble -> localhost | ok: Runtime: 0:00:01.164766 2026-04-25 06:03:11.622934 | 2026-04-25 06:03:11.623062 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-25 06:03:11.659183 | noble | ok 2026-04-25 06:03:11.671842 | noble | included: /var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-25 06:03:11.681239 | 2026-04-25 06:03:11.681328 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-25 06:03:11.704838 | noble | skipping: Conditional result was False 2026-04-25 06:03:11.724144 | 2026-04-25 06:03:11.724299 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-25 06:03:12.325690 | noble | changed 2026-04-25 06:03:12.332023 | 2026-04-25 06:03:12.332115 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-25 06:03:12.630801 | noble | ok 2026-04-25 06:03:12.639461 | 2026-04-25 06:03:12.639646 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-25 06:03:13.369747 | noble | changed 2026-04-25 06:03:13.375713 | 2026-04-25 06:03:13.375807 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-25 06:03:14.120613 | noble | changed 2026-04-25 06:03:14.129122 | 2026-04-25 06:03:14.129251 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-25 06:03:14.153151 | noble | skipping: Conditional result was False 2026-04-25 06:03:14.170376 | 2026-04-25 06:03:14.170542 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-25 06:03:14.604603 | noble -> localhost | changed 2026-04-25 06:03:14.628828 | 2026-04-25 06:03:14.628956 | TASK [add-build-sshkey : Add back temp key] 2026-04-25 06:03:14.975873 | noble -> localhost | Identity added: /var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/7b237830b39d43989a0f85a65b210ff6_id_rsa (zuul-build-sshkey) 2026-04-25 06:03:14.976076 | noble -> localhost | ok: Runtime: 0:00:00.013435 2026-04-25 06:03:14.983230 | 2026-04-25 06:03:14.983318 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-25 06:03:15.438874 | noble | ok 2026-04-25 06:03:15.448430 | 2026-04-25 06:03:15.448576 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-25 06:03:15.482414 | noble | skipping: Conditional result was False 2026-04-25 06:03:15.529273 | 2026-04-25 06:03:15.529373 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-25 06:03:15.981368 | noble | ok 2026-04-25 06:03:16.000495 | 2026-04-25 06:03:16.000727 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-25 06:03:16.047061 | noble | ok 2026-04-25 06:03:16.056909 | 2026-04-25 06:03:16.057029 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-25 06:03:16.313136 | noble -> localhost | ok 2026-04-25 06:03:16.320247 | 2026-04-25 06:03:16.320343 | TASK [validate-host : Collect information about the host] 2026-04-25 06:03:17.856777 | noble | ok 2026-04-25 06:03:17.875113 | 2026-04-25 06:03:17.875263 | TASK [validate-host : Sanitize hostname] 2026-04-25 06:03:17.952807 | noble | ok 2026-04-25 06:03:17.961345 | 2026-04-25 06:03:17.961497 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-25 06:03:18.527967 | noble -> localhost | changed 2026-04-25 06:03:18.540437 | 2026-04-25 06:03:18.540598 | TASK [validate-host : Collect information about zuul worker] 2026-04-25 06:03:19.015497 | noble | ok 2026-04-25 06:03:19.024117 | 2026-04-25 06:03:19.024267 | TASK [validate-host : Write out all zuul information for each host] 2026-04-25 06:03:19.588752 | noble -> localhost | changed 2026-04-25 06:03:19.600339 | 2026-04-25 06:03:19.600483 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-25 06:03:19.912984 | noble | ok 2026-04-25 06:03:19.919562 | 2026-04-25 06:03:19.919694 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-25 06:03:20.996443 | noble | changed: 2026-04-25 06:03:20.996789 | noble | cd+++++++++ src/ 2026-04-25 06:03:20.996847 | noble | cd+++++++++ src/github.com/ 2026-04-25 06:03:20.996888 | noble | cd+++++++++ src/github.com/osism/ 2026-04-25 06:03:20.996922 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-04-25 06:03:20.996955 | noble | localhost | ok: "/var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/logs" 2026-04-25 06:10:35.170590 | noble -> localhost | changed: "/var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/artifacts" 2026-04-25 06:10:35.456223 | noble -> localhost | changed: "/var/lib/zuul/builds/7b237830b39d43989a0f85a65b210ff6/work/docs" 2026-04-25 06:10:35.475545 | 2026-04-25 06:10:35.475679 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-25 06:10:36.813698 | noble | changed: 2026-04-25 06:10:36.814012 | noble | .d..t...... ./ 2026-04-25 06:10:36.814066 | noble | >f+++++++++ osism-ipa.log 2026-04-25 06:10:36.814132 | noble | changed: All items complete 2026-04-25 06:10:36.814178 | 2026-04-25 06:10:37.500329 | noble | changed: .d..t...... ./ 2026-04-25 06:10:38.164640 | noble | changed: .d..t...... ./ 2026-04-25 06:10:38.186924 | 2026-04-25 06:10:38.187075 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-25 06:10:38.223107 | noble | skipping: Conditional result was False 2026-04-25 06:10:38.230014 | noble | skipping: Conditional result was False 2026-04-25 06:10:38.242785 | 2026-04-25 06:10:38.242983 | PLAY RECAP 2026-04-25 06:10:38.243043 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-04-25 06:10:38.243069 | 2026-04-25 06:10:38.377339 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-25 06:10:38.378317 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-25 06:10:39.168362 | 2026-04-25 06:10:39.168537 | PLAY [Base post] 2026-04-25 06:10:39.184750 | 2026-04-25 06:10:39.184932 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-25 06:10:39.878650 | noble | changed 2026-04-25 06:10:39.888194 | 2026-04-25 06:10:39.888822 | PLAY RECAP 2026-04-25 06:10:39.889035 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-25 06:10:39.889262 | 2026-04-25 06:10:40.070974 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-25 06:10:40.071946 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-25 06:10:40.876141 | 2026-04-25 06:10:40.876314 | PLAY [Base post-logs] 2026-04-25 06:10:40.887393 | 2026-04-25 06:10:40.887539 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-25 06:10:41.404205 | localhost | changed 2026-04-25 06:10:41.422018 | 2026-04-25 06:10:41.422211 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-25 06:10:41.448296 | localhost | ok 2026-04-25 06:10:41.451449 | 2026-04-25 06:10:41.451552 | TASK [Set zuul-log-path fact] 2026-04-25 06:10:41.466508 | localhost | ok 2026-04-25 06:10:41.474483 | 2026-04-25 06:10:41.474592 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-25 06:10:41.509686 | localhost | ok 2026-04-25 06:10:41.513352 | 2026-04-25 06:10:41.513469 | TASK [upload-logs : Create log directories] 2026-04-25 06:10:42.037031 | localhost | changed 2026-04-25 06:10:42.039857 | 2026-04-25 06:10:42.039983 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-25 06:10:42.521734 | localhost -> localhost | ok: Runtime: 0:00:00.007048 2026-04-25 06:10:42.529062 | 2026-04-25 06:10:42.529224 | TASK [upload-logs : Upload logs to log server] 2026-04-25 06:10:43.088096 | localhost | Output suppressed because no_log was given 2026-04-25 06:10:43.090029 | 2026-04-25 06:10:43.090139 | LOOP [upload-logs : Compress console log and json output] 2026-04-25 06:10:43.137811 | localhost | skipping: Conditional result was False 2026-04-25 06:10:43.142650 | localhost | skipping: Conditional result was False 2026-04-25 06:10:43.154721 | 2026-04-25 06:10:43.154999 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-25 06:10:43.205449 | localhost | skipping: Conditional result was False 2026-04-25 06:10:43.206029 | 2026-04-25 06:10:43.207823 | localhost | skipping: Conditional result was False 2026-04-25 06:10:43.213428 | 2026-04-25 06:10:43.213605 | LOOP [upload-logs : Upload console log and json output]