2026-09-03 13:06:32.842200 | Job console starting 2026-09-03 13:06:32.855649 | Updating git repos 2026-09-03 13:06:32.873193 | Cloning repos into workspace 2026-09-03 13:06:32.900914 | Restoring repo states 2026-09-03 13:06:32.905580 | Merging changes 2026-09-03 13:06:33.457522 | Checking out repos 2026-09-03 13:06:33.513256 | Preparing playbooks 2026-09-03 13:06:34.871981 | Running Ansible setup 2026-09-03 13:06:41.830377 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-03 13:06:42.745821 | 2026-09-03 13:06:42.745975 | PLAY [Base pre] 2026-09-03 13:06:42.773307 | 2026-09-03 13:06:42.773452 | TASK [Setup log path fact] 2026-09-03 13:06:42.803310 | noble | ok 2026-09-03 13:06:42.830677 | 2026-09-03 13:06:42.830868 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 13:06:42.882438 | noble | ok 2026-09-03 13:06:42.911740 | 2026-09-03 13:06:42.911933 | TASK [emit-job-header : Print job information] 2026-09-03 13:06:42.965221 | # Job Information 2026-09-03 13:06:42.965418 | Ansible Version: 2.16.14 2026-09-03 13:06:42.965454 | Job: openstack-ironic-images-build-osism-esp 2026-09-03 13:06:42.965489 | Pipeline: check 2026-09-03 13:06:42.965514 | Executor: 521e9411259a 2026-09-03 13:06:42.965537 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/221 2026-09-03 13:06:42.965560 | Event ID: d0c99c50-a797-11f1-9a49-d630a630c37f 2026-09-03 13:06:42.972453 | 2026-09-03 13:06:42.972573 | LOOP [emit-job-header : Print node information] 2026-09-03 13:06:43.105595 | noble | ok: 2026-09-03 13:06:43.105796 | noble | # Node Information 2026-09-03 13:06:43.105832 | noble | Inventory Hostname: noble 2026-09-03 13:06:43.105857 | noble | Hostname: ubuntu 2026-09-03 13:06:43.105878 | noble | Username: zuul 2026-09-03 13:06:43.105899 | noble | Distro: Ubuntu 24.04 2026-09-03 13:06:43.105923 | noble | Provider: regiocloud-a 2026-09-03 13:06:43.105944 | noble | Region: 2026-09-03 13:06:43.105965 | noble | Label: ubuntu-noble-uefi 2026-09-03 13:06:43.105985 | noble | Product Name: OpenStack Nova 2026-09-03 13:06:43.106005 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe15:1971 2026-09-03 13:06:43.119885 | 2026-09-03 13:06:43.120022 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-03 13:06:43.766250 | noble -> localhost | changed 2026-09-03 13:06:43.777539 | 2026-09-03 13:06:43.777678 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-03 13:06:45.061147 | noble -> localhost | changed 2026-09-03 13:06:45.077270 | 2026-09-03 13:06:45.077364 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-03 13:06:45.403282 | noble -> localhost | ok 2026-09-03 13:06:45.408824 | 2026-09-03 13:06:45.408910 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-03 13:06:45.425619 | noble | ok 2026-09-03 13:06:45.444801 | noble | included: /var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-03 13:06:45.467051 | 2026-09-03 13:06:45.467143 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-03 13:06:47.409637 | noble -> localhost | Generating public/private rsa key pair. 2026-09-03 13:06:47.409854 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/77af6bf4704b47089e62ae7e9f8e8f01_id_rsa 2026-09-03 13:06:47.409894 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/77af6bf4704b47089e62ae7e9f8e8f01_id_rsa.pub 2026-09-03 13:06:47.409920 | noble -> localhost | The key fingerprint is: 2026-09-03 13:06:47.409944 | noble -> localhost | SHA256:vscWSaT0mNJxgkZo2TzFTm52EDdPK/qzgehrci3Fx10 zuul-build-sshkey 2026-09-03 13:06:47.409966 | noble -> localhost | The key's randomart image is: 2026-09-03 13:06:47.409987 | noble -> localhost | +---[RSA 3072]----+ 2026-09-03 13:06:47.410009 | noble -> localhost | | *.+o.o . | 2026-09-03 13:06:47.410042 | noble -> localhost | | + * B.o+ . | 2026-09-03 13:06:47.410065 | noble -> localhost | | . . B @. o | 2026-09-03 13:06:47.410085 | noble -> localhost | | . X.+. E | 2026-09-03 13:06:47.410105 | noble -> localhost | | =S+ o . | 2026-09-03 13:06:47.410133 | noble -> localhost | | ooo= . | 2026-09-03 13:06:47.410154 | noble -> localhost | | .ooo+. | 2026-09-03 13:06:47.410174 | noble -> localhost | | ..+ ..++ | 2026-09-03 13:06:47.410198 | noble -> localhost | | +oo.o. | 2026-09-03 13:06:47.410220 | noble -> localhost | +----[SHA256]-----+ 2026-09-03 13:06:47.410271 | noble -> localhost | ok: Runtime: 0:00:01.320689 2026-09-03 13:06:47.422004 | 2026-09-03 13:06:47.422108 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-03 13:06:47.460258 | noble | ok 2026-09-03 13:06:47.480518 | noble | included: /var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-03 13:06:47.493904 | 2026-09-03 13:06:47.493995 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-03 13:06:47.531219 | noble | skipping: Conditional result was False 2026-09-03 13:06:47.538088 | 2026-09-03 13:06:47.538177 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-03 13:06:48.164502 | noble | changed 2026-09-03 13:06:48.171653 | 2026-09-03 13:06:48.171755 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-03 13:06:48.490989 | noble | ok 2026-09-03 13:06:48.502193 | 2026-09-03 13:06:48.502303 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-03 13:06:49.353244 | noble | changed 2026-09-03 13:06:49.362935 | 2026-09-03 13:06:49.363045 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-03 13:06:50.147594 | noble | changed 2026-09-03 13:06:50.153716 | 2026-09-03 13:06:50.153829 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-03 13:06:50.177197 | noble | skipping: Conditional result was False 2026-09-03 13:06:50.184700 | 2026-09-03 13:06:50.184814 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-03 13:06:50.571792 | noble -> localhost | changed 2026-09-03 13:06:50.581825 | 2026-09-03 13:06:50.581908 | TASK [add-build-sshkey : Add back temp key] 2026-09-03 13:06:50.826803 | noble -> localhost | Identity added: /var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/77af6bf4704b47089e62ae7e9f8e8f01_id_rsa (zuul-build-sshkey) 2026-09-03 13:06:50.828411 | noble -> localhost | ok: Runtime: 0:00:00.008566 2026-09-03 13:06:50.837293 | 2026-09-03 13:06:50.837395 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-03 13:06:51.286407 | noble | ok 2026-09-03 13:06:51.303783 | 2026-09-03 13:06:51.303883 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-03 13:06:51.326692 | noble | skipping: Conditional result was False 2026-09-03 13:06:51.369570 | 2026-09-03 13:06:51.369670 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-03 13:06:52.014111 | noble | ok 2026-09-03 13:06:52.023334 | 2026-09-03 13:06:52.023425 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-03 13:06:52.051653 | noble | ok 2026-09-03 13:06:52.056375 | 2026-09-03 13:06:52.056446 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-03 13:06:52.320993 | noble -> localhost | ok 2026-09-03 13:06:52.326797 | 2026-09-03 13:06:52.326937 | TASK [validate-host : Collect information about the host] 2026-09-03 13:06:53.800327 | noble | ok 2026-09-03 13:06:53.811893 | 2026-09-03 13:06:53.811983 | TASK [validate-host : Sanitize hostname] 2026-09-03 13:06:53.871547 | noble | ok 2026-09-03 13:06:53.878719 | 2026-09-03 13:06:53.878865 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-03 13:06:54.357702 | noble -> localhost | changed 2026-09-03 13:06:54.369993 | 2026-09-03 13:06:54.370129 | TASK [validate-host : Collect information about zuul worker] 2026-09-03 13:06:54.884158 | noble | ok 2026-09-03 13:06:54.889467 | 2026-09-03 13:06:54.889558 | TASK [validate-host : Write out all zuul information for each host] 2026-09-03 13:06:55.411932 | noble -> localhost | changed 2026-09-03 13:06:55.423050 | 2026-09-03 13:06:55.423141 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-03 13:06:55.759748 | noble | ok 2026-09-03 13:06:55.769293 | 2026-09-03 13:06:55.769418 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-03 13:06:56.665077 | noble | changed: 2026-09-03 13:06:56.665305 | noble | cd+++++++++ src/ 2026-09-03 13:06:56.665366 | noble | cd+++++++++ src/github.com/ 2026-09-03 13:06:56.665392 | noble | cd+++++++++ src/github.com/osism/ 2026-09-03 13:06:56.665413 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-09-03 13:06:56.665434 | noble | localhost | ok: "/var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/logs" 2026-09-03 13:10:57.640684 | noble -> localhost | changed: "/var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/artifacts" 2026-09-03 13:10:57.905777 | noble -> localhost | changed: "/var/lib/zuul/builds/77af6bf4704b47089e62ae7e9f8e8f01/work/docs" 2026-09-03 13:10:57.925631 | 2026-09-03 13:10:57.925803 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-03 13:10:59.234346 | noble | changed: 2026-09-03 13:10:59.236363 | noble | .d..t...... ./ 2026-09-03 13:10:59.236417 | noble | >f+++++++++ net-debug.post.txt 2026-09-03 13:10:59.236443 | noble | >f+++++++++ net-debug.pre.txt 2026-09-03 13:10:59.236465 | noble | >f+++++++++ osism-esp.log 2026-09-03 13:10:59.236487 | noble | >f+++++++++ sudo-debug.txt 2026-09-03 13:10:59.236508 | noble | >f+++++++++ sudo-strace.log 2026-09-03 13:10:59.236532 | noble | >f+++++++++ sudo-strace.log.time 2026-09-03 13:10:59.236577 | noble | changed: All items complete 2026-09-03 13:10:59.236603 | 2026-09-03 13:10:59.932390 | noble | changed: .d..t...... ./ 2026-09-03 13:11:00.597128 | noble | changed: .d..t...... ./ 2026-09-03 13:11:00.616024 | 2026-09-03 13:11:00.616148 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-03 13:11:00.952585 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.010567 2026-09-03 13:11:01.223118 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.010210 2026-09-03 13:11:01.241331 | 2026-09-03 13:11:01.241439 | PLAY RECAP 2026-09-03 13:11:01.241506 | noble | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-03 13:11:01.241540 | 2026-09-03 13:11:01.399656 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-03 13:11:01.401545 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 13:11:02.154267 | 2026-09-03 13:11:02.154432 | PLAY [Base post] 2026-09-03 13:11:02.176165 | 2026-09-03 13:11:02.176313 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-03 13:11:02.881386 | noble | changed 2026-09-03 13:11:02.890824 | 2026-09-03 13:11:02.890964 | PLAY RECAP 2026-09-03 13:11:02.891035 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-03 13:11:02.891102 | 2026-09-03 13:11:03.003878 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 13:11:03.005808 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-03 13:11:03.818052 | 2026-09-03 13:11:03.818217 | PLAY [Base post-logs] 2026-09-03 13:11:03.829311 | 2026-09-03 13:11:03.829446 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-03 13:11:04.272456 | localhost | changed 2026-09-03 13:11:04.283064 | 2026-09-03 13:11:04.283226 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-03 13:11:04.320055 | localhost | ok 2026-09-03 13:11:04.325710 | 2026-09-03 13:11:04.325825 | TASK [Set zuul-log-path fact] 2026-09-03 13:11:04.342073 | localhost | ok 2026-09-03 13:11:04.352068 | 2026-09-03 13:11:04.352189 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 13:11:04.388137 | localhost | ok 2026-09-03 13:11:04.392862 | 2026-09-03 13:11:04.393085 | TASK [upload-logs : Create log directories] 2026-09-03 13:11:04.922659 | localhost | changed 2026-09-03 13:11:04.926752 | 2026-09-03 13:11:04.926959 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-03 13:11:05.440107 | localhost -> localhost | ok: Runtime: 0:00:00.004217 2026-09-03 13:11:05.444236 | 2026-09-03 13:11:05.444353 | TASK [upload-logs : Upload logs to log server] 2026-09-03 13:11:06.014632 | localhost | Output suppressed because no_log was given 2026-09-03 13:11:06.016578 | 2026-09-03 13:11:06.016727 | LOOP [upload-logs : Compress console log and json output] 2026-09-03 13:11:06.076911 | localhost | skipping: Conditional result was False 2026-09-03 13:11:06.084191 | localhost | skipping: Conditional result was False 2026-09-03 13:11:06.090212 | 2026-09-03 13:11:06.090367 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-03 13:11:06.152759 | localhost | skipping: Conditional result was False 2026-09-03 13:11:06.153391 | 2026-09-03 13:11:06.155307 | localhost | skipping: Conditional result was False 2026-09-03 13:11:06.159095 | 2026-09-03 13:11:06.159207 | LOOP [upload-logs : Upload console log and json output]