2026-06-06 06:03:02.513931 | Job console starting 2026-06-06 06:03:02.533935 | Updating git repos 2026-06-06 06:03:02.581018 | Cloning repos into workspace 2026-06-06 06:03:02.639720 | Restoring repo states 2026-06-06 06:03:02.667852 | Merging changes 2026-06-06 06:03:02.667879 | Checking out repos 2026-06-06 06:03:02.770071 | Preparing playbooks 2026-06-06 06:03:03.683261 | Running Ansible setup 2026-06-06 06:03:10.248362 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-06 06:03:11.124528 | 2026-06-06 06:03:11.124901 | PLAY [Base pre] 2026-06-06 06:03:11.148181 | 2026-06-06 06:03:11.148422 | TASK [Setup log path fact] 2026-06-06 06:03:11.175310 | noble | ok 2026-06-06 06:03:11.196195 | 2026-06-06 06:03:11.196437 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-06 06:03:11.239634 | noble | ok 2026-06-06 06:03:11.255689 | 2026-06-06 06:03:11.255939 | TASK [emit-job-header : Print job information] 2026-06-06 06:03:11.297785 | # Job Information 2026-06-06 06:03:11.298160 | Ansible Version: 2.16.14 2026-06-06 06:03:11.298204 | Job: openstack-ironic-images-publish-osism-esp 2026-06-06 06:03:11.298258 | Pipeline: periodic-weekly 2026-06-06 06:03:11.298286 | Executor: 521e9411259a 2026-06-06 06:03:11.298307 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-06-06 06:03:11.298329 | Event ID: 2d9cb639f2254d8d948d09b9a8bd2e16 2026-06-06 06:03:11.307074 | 2026-06-06 06:03:11.307237 | LOOP [emit-job-header : Print node information] 2026-06-06 06:03:11.426478 | noble | ok: 2026-06-06 06:03:11.426878 | noble | # Node Information 2026-06-06 06:03:11.426944 | noble | Inventory Hostname: noble 2026-06-06 06:03:11.426986 | noble | Hostname: ubuntu 2026-06-06 06:03:11.427021 | noble | Username: zuul 2026-06-06 06:03:11.427056 | noble | Distro: Ubuntu 24.04 2026-06-06 06:03:11.427090 | noble | Provider: regiocloud-a 2026-06-06 06:03:11.427121 | noble | Region: 2026-06-06 06:03:11.427154 | noble | Label: ubuntu-noble-uefi 2026-06-06 06:03:11.427185 | noble | Product Name: OpenStack Nova 2026-06-06 06:03:11.427217 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe12:4065 2026-06-06 06:03:11.450968 | 2026-06-06 06:03:11.451167 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-06 06:03:11.963559 | noble -> localhost | changed 2026-06-06 06:03:11.976189 | 2026-06-06 06:03:11.976350 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-06 06:03:13.181309 | noble -> localhost | changed 2026-06-06 06:03:13.196545 | 2026-06-06 06:03:13.196699 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-06 06:03:13.507561 | noble -> localhost | ok 2026-06-06 06:03:13.520156 | 2026-06-06 06:03:13.520320 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-06 06:03:13.550564 | noble | ok 2026-06-06 06:03:13.569752 | noble | included: /var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-06 06:03:13.577136 | 2026-06-06 06:03:13.577326 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-06 06:03:14.939571 | noble -> localhost | Generating public/private rsa key pair. 2026-06-06 06:03:14.940110 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/efe8b2f30f72490b968ee495bd41a974_id_rsa 2026-06-06 06:03:14.940221 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/efe8b2f30f72490b968ee495bd41a974_id_rsa.pub 2026-06-06 06:03:14.940296 | noble -> localhost | The key fingerprint is: 2026-06-06 06:03:14.940362 | noble -> localhost | SHA256:TTCbn6qlClt4WeK7ewT1XQs54KyUnmxz2Dphvb3wG34 zuul-build-sshkey 2026-06-06 06:03:14.940425 | noble -> localhost | The key's randomart image is: 2026-06-06 06:03:14.940485 | noble -> localhost | +---[RSA 3072]----+ 2026-06-06 06:03:14.940543 | noble -> localhost | | +. . | 2026-06-06 06:03:14.940624 | noble -> localhost | | .+ =+ . | 2026-06-06 06:03:14.940686 | noble -> localhost | | .o.=..+ . | 2026-06-06 06:03:14.940743 | noble -> localhost | | .+ *.+... | 2026-06-06 06:03:14.940839 | noble -> localhost | | ..% S + | 2026-06-06 06:03:14.940911 | noble -> localhost | | o *.= + | 2026-06-06 06:03:14.940970 | noble -> localhost | | o =.o = o | 2026-06-06 06:03:14.941025 | noble -> localhost | | = ..= + oE | 2026-06-06 06:03:14.941084 | noble -> localhost | | . ==o =o | 2026-06-06 06:03:14.941143 | noble -> localhost | +----[SHA256]-----+ 2026-06-06 06:03:14.941303 | noble -> localhost | ok: Runtime: 0:00:00.874899 2026-06-06 06:03:14.957844 | 2026-06-06 06:03:14.958007 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-06 06:03:14.989037 | noble | ok 2026-06-06 06:03:15.000540 | noble | included: /var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-06 06:03:15.011424 | 2026-06-06 06:03:15.011540 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-06 06:03:15.035854 | noble | skipping: Conditional result was False 2026-06-06 06:03:15.050376 | 2026-06-06 06:03:15.050535 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-06 06:03:15.847376 | noble | changed 2026-06-06 06:03:15.871033 | 2026-06-06 06:03:15.871930 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-06 06:03:16.254173 | noble | ok 2026-06-06 06:03:16.262956 | 2026-06-06 06:03:16.263093 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-06 06:03:17.138022 | noble | changed 2026-06-06 06:03:17.144721 | 2026-06-06 06:03:17.144869 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-06 06:03:18.098531 | noble | changed 2026-06-06 06:03:18.106554 | 2026-06-06 06:03:18.106675 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-06 06:03:18.131284 | noble | skipping: Conditional result was False 2026-06-06 06:03:18.138490 | 2026-06-06 06:03:18.138612 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-06 06:03:18.610999 | noble -> localhost | changed 2026-06-06 06:03:18.627675 | 2026-06-06 06:03:18.627837 | TASK [add-build-sshkey : Add back temp key] 2026-06-06 06:03:18.982254 | noble -> localhost | Identity added: /var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/efe8b2f30f72490b968ee495bd41a974_id_rsa (zuul-build-sshkey) 2026-06-06 06:03:18.982504 | noble -> localhost | ok: Runtime: 0:00:00.013532 2026-06-06 06:03:18.989906 | 2026-06-06 06:03:18.990019 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-06 06:03:19.480699 | noble | ok 2026-06-06 06:03:19.486952 | 2026-06-06 06:03:19.487071 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-06 06:03:19.512441 | noble | skipping: Conditional result was False 2026-06-06 06:03:19.618123 | 2026-06-06 06:03:19.618329 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-06 06:03:20.157718 | noble | ok 2026-06-06 06:03:20.169841 | 2026-06-06 06:03:20.169980 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-06 06:03:20.212617 | noble | ok 2026-06-06 06:03:20.219206 | 2026-06-06 06:03:20.219317 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-06 06:03:20.560896 | noble -> localhost | ok 2026-06-06 06:03:20.571155 | 2026-06-06 06:03:20.571315 | TASK [validate-host : Collect information about the host] 2026-06-06 06:03:22.155432 | noble | ok 2026-06-06 06:03:22.171896 | 2026-06-06 06:03:22.172032 | TASK [validate-host : Sanitize hostname] 2026-06-06 06:03:22.237013 | noble | ok 2026-06-06 06:03:22.245340 | 2026-06-06 06:03:22.245497 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-06 06:03:22.856573 | noble -> localhost | changed 2026-06-06 06:03:22.864763 | 2026-06-06 06:03:22.864959 | TASK [validate-host : Collect information about zuul worker] 2026-06-06 06:03:23.377213 | noble | ok 2026-06-06 06:03:23.389727 | 2026-06-06 06:03:23.390031 | TASK [validate-host : Write out all zuul information for each host] 2026-06-06 06:03:24.009889 | noble -> localhost | changed 2026-06-06 06:03:24.022296 | 2026-06-06 06:03:24.022429 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-06 06:03:24.382754 | noble | ok 2026-06-06 06:03:24.391385 | 2026-06-06 06:03:24.391520 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-06 06:03:25.335091 | noble | changed: 2026-06-06 06:03:25.335331 | noble | cd+++++++++ src/ 2026-06-06 06:03:25.335365 | noble | cd+++++++++ src/github.com/ 2026-06-06 06:03:25.335391 | noble | cd+++++++++ src/github.com/osism/ 2026-06-06 06:03:25.335413 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-06-06 06:03:25.335434 | noble | localhost | ok: "/var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/logs" 2026-06-06 06:06:52.048439 | noble -> localhost | changed: "/var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/artifacts" 2026-06-06 06:06:52.311992 | noble -> localhost | changed: "/var/lib/zuul/builds/efe8b2f30f72490b968ee495bd41a974/work/docs" 2026-06-06 06:06:52.328101 | 2026-06-06 06:06:52.328364 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-06 06:06:53.715287 | noble | changed: 2026-06-06 06:06:53.715820 | noble | .d..t...... ./ 2026-06-06 06:06:53.715925 | noble | >f+++++++++ osism-esp.log 2026-06-06 06:06:53.716049 | noble | >f+++++++++ sudo-debug.txt 2026-06-06 06:06:53.716149 | noble | >f+++++++++ sudo-strace.log 2026-06-06 06:06:53.716204 | noble | >f+++++++++ sudo-strace.log.time 2026-06-06 06:06:53.716325 | noble | changed: All items complete 2026-06-06 06:06:53.716390 | 2026-06-06 06:06:54.423354 | noble | changed: .d..t...... ./ 2026-06-06 06:06:55.155453 | noble | changed: .d..t...... ./ 2026-06-06 06:06:55.180301 | 2026-06-06 06:06:55.180439 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-06 06:06:55.217598 | noble | skipping: Conditional result was False 2026-06-06 06:06:55.220350 | noble | skipping: Conditional result was False 2026-06-06 06:06:55.240143 | 2026-06-06 06:06:55.240279 | PLAY RECAP 2026-06-06 06:06:55.240361 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-06 06:06:55.240398 | 2026-06-06 06:06:55.378006 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-06 06:06:55.381336 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-06 06:06:56.125856 | 2026-06-06 06:06:56.126072 | PLAY [Base post] 2026-06-06 06:06:56.141579 | 2026-06-06 06:06:56.141747 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-06 06:06:56.831106 | noble | changed 2026-06-06 06:06:56.841698 | 2026-06-06 06:06:56.841838 | PLAY RECAP 2026-06-06 06:06:56.841917 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-06 06:06:56.842042 | 2026-06-06 06:06:56.968568 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-06 06:06:56.972364 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-06 06:06:57.810765 | 2026-06-06 06:06:57.811000 | PLAY [Base post-logs] 2026-06-06 06:06:57.823218 | 2026-06-06 06:06:57.823362 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-06 06:06:58.313000 | localhost | changed 2026-06-06 06:06:58.330338 | 2026-06-06 06:06:58.330552 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-06 06:06:58.370167 | localhost | ok 2026-06-06 06:06:58.376447 | 2026-06-06 06:06:58.376677 | TASK [Set zuul-log-path fact] 2026-06-06 06:06:58.397005 | localhost | ok 2026-06-06 06:06:58.411395 | 2026-06-06 06:06:58.411534 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-06 06:06:58.441468 | localhost | ok 2026-06-06 06:06:58.452272 | 2026-06-06 06:06:58.452465 | TASK [upload-logs : Create log directories] 2026-06-06 06:06:59.006786 | localhost | changed 2026-06-06 06:06:59.013529 | 2026-06-06 06:06:59.013784 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-06 06:06:59.512546 | localhost -> localhost | ok: Runtime: 0:00:00.006875 2026-06-06 06:06:59.525487 | 2026-06-06 06:06:59.525762 | TASK [upload-logs : Upload logs to log server] 2026-06-06 06:07:00.086010 | localhost | Output suppressed because no_log was given 2026-06-06 06:07:00.088028 | 2026-06-06 06:07:00.088140 | LOOP [upload-logs : Compress console log and json output] 2026-06-06 06:07:00.132412 | localhost | skipping: Conditional result was False 2026-06-06 06:07:00.140274 | localhost | skipping: Conditional result was False 2026-06-06 06:07:00.146467 | 2026-06-06 06:07:00.146609 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-06 06:07:00.189573 | localhost | skipping: Conditional result was False 2026-06-06 06:07:00.189880 | 2026-06-06 06:07:00.196433 | localhost | skipping: Conditional result was False 2026-06-06 06:07:00.206535 | 2026-06-06 06:07:00.206759 | LOOP [upload-logs : Upload console log and json output]