2026-02-28 06:02:54.047950 | Job console starting 2026-02-28 06:02:54.072959 | Updating git repos 2026-02-28 06:02:54.099246 | Cloning repos into workspace 2026-02-28 06:02:54.179296 | Restoring repo states 2026-02-28 06:02:54.188921 | Merging changes 2026-02-28 06:02:54.188959 | Checking out repos 2026-02-28 06:02:54.255589 | Preparing playbooks 2026-02-28 06:02:54.981614 | Running Ansible setup 2026-02-28 06:03:01.032647 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-28 06:03:01.785402 | 2026-02-28 06:03:01.785566 | PLAY [Base pre] 2026-02-28 06:03:01.802786 | 2026-02-28 06:03:01.802961 | TASK [Setup log path fact] 2026-02-28 06:03:01.823076 | noble | ok 2026-02-28 06:03:01.840987 | 2026-02-28 06:03:01.841184 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-28 06:03:01.880710 | noble | ok 2026-02-28 06:03:01.892420 | 2026-02-28 06:03:01.892547 | TASK [emit-job-header : Print job information] 2026-02-28 06:03:01.931820 | # Job Information 2026-02-28 06:03:01.932006 | Ansible Version: 2.16.14 2026-02-28 06:03:01.932042 | Job: openstack-ironic-images-publish-osism-esp 2026-02-28 06:03:01.932075 | Pipeline: periodic-weekly 2026-02-28 06:03:01.932098 | Executor: 521e9411259a 2026-02-28 06:03:01.932155 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-02-28 06:03:01.932183 | Event ID: 28d8dba64c0a483cb0b997f5cba7c0d2 2026-02-28 06:03:01.939300 | 2026-02-28 06:03:01.940357 | LOOP [emit-job-header : Print node information] 2026-02-28 06:03:02.060586 | noble | ok: 2026-02-28 06:03:02.060784 | noble | # Node Information 2026-02-28 06:03:02.060818 | noble | Inventory Hostname: noble 2026-02-28 06:03:02.060843 | noble | Hostname: ubuntu 2026-02-28 06:03:02.060865 | noble | Username: zuul 2026-02-28 06:03:02.060885 | noble | Distro: Ubuntu 24.04 2026-02-28 06:03:02.060909 | noble | Provider: regiocloud-a 2026-02-28 06:03:02.060929 | noble | Region: 2026-02-28 06:03:02.060951 | noble | Label: ubuntu-noble-uefi 2026-02-28 06:03:02.060971 | noble | Product Name: OpenStack Nova 2026-02-28 06:03:02.060991 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe93:760e 2026-02-28 06:03:02.076689 | 2026-02-28 06:03:02.076831 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-28 06:03:02.648141 | noble -> localhost | changed 2026-02-28 06:03:02.656804 | 2026-02-28 06:03:02.656937 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-28 06:03:03.828669 | noble -> localhost | changed 2026-02-28 06:03:03.843043 | 2026-02-28 06:03:03.843200 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-28 06:03:04.182893 | noble -> localhost | ok 2026-02-28 06:03:04.190581 | 2026-02-28 06:03:04.190724 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-28 06:03:04.230093 | noble | ok 2026-02-28 06:03:04.252266 | noble | included: /var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-28 06:03:04.260568 | 2026-02-28 06:03:04.260686 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-28 06:03:05.259623 | noble -> localhost | Generating public/private rsa key pair. 2026-02-28 06:03:05.260024 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/2aea9e5860bc4da49f0d4bc18aaabb3d_id_rsa 2026-02-28 06:03:05.260101 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/2aea9e5860bc4da49f0d4bc18aaabb3d_id_rsa.pub 2026-02-28 06:03:05.260197 | noble -> localhost | The key fingerprint is: 2026-02-28 06:03:05.260249 | noble -> localhost | SHA256:4di4Q7TYPKvV1X14d2WFnTSH8ark+xePmexSEhEzvrU zuul-build-sshkey 2026-02-28 06:03:05.260296 | noble -> localhost | The key's randomart image is: 2026-02-28 06:03:05.260342 | noble -> localhost | +---[RSA 3072]----+ 2026-02-28 06:03:05.260385 | noble -> localhost | | +.oB+| 2026-02-28 06:03:05.260446 | noble -> localhost | | ..ooo=| 2026-02-28 06:03:05.260490 | noble -> localhost | | . . ... +| 2026-02-28 06:03:05.260533 | noble -> localhost | | = * . ..+ =.| 2026-02-28 06:03:05.260574 | noble -> localhost | | . O S . +.E =| 2026-02-28 06:03:05.260626 | noble -> localhost | | . = . o...+o| 2026-02-28 06:03:05.260671 | noble -> localhost | | = . o+ +o| 2026-02-28 06:03:05.260713 | noble -> localhost | | o . ..= o| 2026-02-28 06:03:05.260758 | noble -> localhost | | . .+o. | 2026-02-28 06:03:05.260801 | noble -> localhost | +----[SHA256]-----+ 2026-02-28 06:03:05.260905 | noble -> localhost | ok: Runtime: 0:00:00.473654 2026-02-28 06:03:05.275859 | 2026-02-28 06:03:05.276017 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-28 06:03:05.316620 | noble | ok 2026-02-28 06:03:05.326784 | noble | included: /var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-28 06:03:05.337065 | 2026-02-28 06:03:05.337229 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-28 06:03:05.362027 | noble | skipping: Conditional result was False 2026-02-28 06:03:05.370103 | 2026-02-28 06:03:05.370262 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-28 06:03:06.049252 | noble | changed 2026-02-28 06:03:06.057366 | 2026-02-28 06:03:06.057483 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-28 06:03:06.368355 | noble | ok 2026-02-28 06:03:06.377858 | 2026-02-28 06:03:06.378002 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-28 06:03:07.121845 | noble | changed 2026-02-28 06:03:07.128161 | 2026-02-28 06:03:07.128278 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-28 06:03:07.881581 | noble | changed 2026-02-28 06:03:07.891727 | 2026-02-28 06:03:07.891884 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-28 06:03:07.916485 | noble | skipping: Conditional result was False 2026-02-28 06:03:07.939067 | 2026-02-28 06:03:07.939304 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-28 06:03:08.400366 | noble -> localhost | changed 2026-02-28 06:03:08.415696 | 2026-02-28 06:03:08.415824 | TASK [add-build-sshkey : Add back temp key] 2026-02-28 06:03:08.763118 | noble -> localhost | Identity added: /var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/2aea9e5860bc4da49f0d4bc18aaabb3d_id_rsa (zuul-build-sshkey) 2026-02-28 06:03:08.763376 | noble -> localhost | ok: Runtime: 0:00:00.012591 2026-02-28 06:03:08.771460 | 2026-02-28 06:03:08.771563 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-28 06:03:09.226766 | noble | ok 2026-02-28 06:03:09.233106 | 2026-02-28 06:03:09.233241 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-28 06:03:09.257241 | noble | skipping: Conditional result was False 2026-02-28 06:03:09.308859 | 2026-02-28 06:03:09.308997 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-28 06:03:09.733963 | noble | ok 2026-02-28 06:03:09.745237 | 2026-02-28 06:03:09.745360 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-28 06:03:09.785204 | noble | ok 2026-02-28 06:03:09.792921 | 2026-02-28 06:03:09.793044 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-28 06:03:10.100238 | noble -> localhost | ok 2026-02-28 06:03:10.107939 | 2026-02-28 06:03:10.108057 | TASK [validate-host : Collect information about the host] 2026-02-28 06:03:11.534557 | noble | ok 2026-02-28 06:03:11.551407 | 2026-02-28 06:03:11.551539 | TASK [validate-host : Sanitize hostname] 2026-02-28 06:03:11.621648 | noble | ok 2026-02-28 06:03:11.627243 | 2026-02-28 06:03:11.627361 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-28 06:03:12.179055 | noble -> localhost | changed 2026-02-28 06:03:12.185677 | 2026-02-28 06:03:12.185788 | TASK [validate-host : Collect information about zuul worker] 2026-02-28 06:03:12.656342 | noble | ok 2026-02-28 06:03:12.664468 | 2026-02-28 06:03:12.664655 | TASK [validate-host : Write out all zuul information for each host] 2026-02-28 06:03:13.213279 | noble -> localhost | changed 2026-02-28 06:03:13.224393 | 2026-02-28 06:03:13.224512 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-28 06:03:13.564332 | noble | ok 2026-02-28 06:03:13.574017 | 2026-02-28 06:03:13.574167 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-28 06:03:14.476346 | noble | changed: 2026-02-28 06:03:14.476563 | noble | cd+++++++++ src/ 2026-02-28 06:03:14.476596 | noble | cd+++++++++ src/github.com/ 2026-02-28 06:03:14.476621 | noble | cd+++++++++ src/github.com/osism/ 2026-02-28 06:03:14.476642 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-02-28 06:03:14.476663 | noble | localhost | ok: "/var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/logs" 2026-02-28 06:05:56.860442 | noble -> localhost | changed: "/var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/artifacts" 2026-02-28 06:05:57.129421 | noble -> localhost | changed: "/var/lib/zuul/builds/2aea9e5860bc4da49f0d4bc18aaabb3d/work/docs" 2026-02-28 06:05:57.145278 | 2026-02-28 06:05:57.145416 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-28 06:05:58.459991 | noble | changed: 2026-02-28 06:05:58.460375 | noble | .d..t...... ./ 2026-02-28 06:05:58.460441 | noble | >f+++++++++ osism-esp.log 2026-02-28 06:05:58.460545 | noble | changed: All items complete 2026-02-28 06:05:58.460621 | 2026-02-28 06:05:59.108917 | noble | changed: .d..t...... ./ 2026-02-28 06:05:59.767773 | noble | changed: .d..t...... ./ 2026-02-28 06:05:59.792628 | 2026-02-28 06:05:59.792757 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-28 06:05:59.828087 | noble | skipping: Conditional result was False 2026-02-28 06:05:59.830668 | noble | skipping: Conditional result was False 2026-02-28 06:05:59.855933 | 2026-02-28 06:05:59.856036 | PLAY RECAP 2026-02-28 06:05:59.856117 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-02-28 06:05:59.856158 | 2026-02-28 06:05:59.953096 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-02-28 06:05:59.954058 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-28 06:06:00.624096 | 2026-02-28 06:06:00.624237 | PLAY [Base post] 2026-02-28 06:06:00.637222 | 2026-02-28 06:06:00.637328 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-28 06:06:01.263214 | noble | changed 2026-02-28 06:06:01.272455 | 2026-02-28 06:06:01.272559 | PLAY RECAP 2026-02-28 06:06:01.272632 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-28 06:06:01.272704 | 2026-02-28 06:06:01.357342 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-28 06:06:01.358176 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-28 06:06:02.076807 | 2026-02-28 06:06:02.076940 | PLAY [Base post-logs] 2026-02-28 06:06:02.086628 | 2026-02-28 06:06:02.086741 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-28 06:06:02.509734 | localhost | changed 2026-02-28 06:06:02.528158 | 2026-02-28 06:06:02.528333 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-28 06:06:02.566459 | localhost | ok 2026-02-28 06:06:02.573629 | 2026-02-28 06:06:02.573789 | TASK [Set zuul-log-path fact] 2026-02-28 06:06:02.591942 | localhost | ok 2026-02-28 06:06:02.605377 | 2026-02-28 06:06:02.605504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-28 06:06:02.634318 | localhost | ok 2026-02-28 06:06:02.640740 | 2026-02-28 06:06:02.640903 | TASK [upload-logs : Create log directories] 2026-02-28 06:06:03.092085 | localhost | changed 2026-02-28 06:06:03.098110 | 2026-02-28 06:06:03.098298 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-28 06:06:03.538437 | localhost -> localhost | ok: Runtime: 0:00:00.006485 2026-02-28 06:06:03.542201 | 2026-02-28 06:06:03.542300 | TASK [upload-logs : Upload logs to log server] 2026-02-28 06:06:04.067679 | localhost | Output suppressed because no_log was given 2026-02-28 06:06:04.072148 | 2026-02-28 06:06:04.072372 | LOOP [upload-logs : Compress console log and json output] 2026-02-28 06:06:04.117867 | localhost | skipping: Conditional result was False 2026-02-28 06:06:04.122601 | localhost | skipping: Conditional result was False 2026-02-28 06:06:04.135554 | 2026-02-28 06:06:04.135762 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-28 06:06:04.177009 | localhost | skipping: Conditional result was False 2026-02-28 06:06:04.177565 | 2026-02-28 06:06:04.180634 | localhost | skipping: Conditional result was False 2026-02-28 06:06:04.187526 | 2026-02-28 06:06:04.187736 | LOOP [upload-logs : Upload console log and json output]