2026-02-23 13:49:38.114691 | Job console starting 2026-02-23 13:49:38.134706 | Updating git repos 2026-02-23 13:49:38.167812 | Cloning repos into workspace 2026-02-23 13:49:38.232921 | Restoring repo states 2026-02-23 13:49:38.255970 | Merging changes 2026-02-23 13:49:38.892874 | Checking out repos 2026-02-23 13:49:38.978375 | Preparing playbooks 2026-02-23 13:49:39.665567 | Running Ansible setup 2026-02-23 13:49:46.564278 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-23 13:49:47.644541 | 2026-02-23 13:49:47.649857 | PLAY [Base pre] 2026-02-23 13:49:47.678975 | 2026-02-23 13:49:47.679123 | TASK [Setup log path fact] 2026-02-23 13:49:47.718658 | noble | ok 2026-02-23 13:49:47.750145 | 2026-02-23 13:49:47.750282 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 13:49:47.839801 | noble | ok 2026-02-23 13:49:47.855344 | 2026-02-23 13:49:47.855460 | TASK [emit-job-header : Print job information] 2026-02-23 13:49:47.895937 | # Job Information 2026-02-23 13:49:47.896115 | Ansible Version: 2.16.14 2026-02-23 13:49:47.896152 | Job: openstack-ironic-images-build-osism-esp 2026-02-23 13:49:47.896185 | Pipeline: check 2026-02-23 13:49:47.896208 | Executor: 521e9411259a 2026-02-23 13:49:47.896228 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/171 2026-02-23 13:49:47.896250 | Event ID: 0c1fd740-10be-11f1-8bcf-31ce36b8d8da 2026-02-23 13:49:47.902691 | 2026-02-23 13:49:47.902786 | LOOP [emit-job-header : Print node information] 2026-02-23 13:49:48.073576 | noble | ok: 2026-02-23 13:49:48.073734 | noble | # Node Information 2026-02-23 13:49:48.073768 | noble | Inventory Hostname: noble 2026-02-23 13:49:48.073792 | noble | Hostname: ubuntu 2026-02-23 13:49:48.073813 | noble | Username: zuul 2026-02-23 13:49:48.073833 | noble | Distro: Ubuntu 24.04 2026-02-23 13:49:48.073856 | noble | Provider: regiocloud-a 2026-02-23 13:49:48.073877 | noble | Region: 2026-02-23 13:49:48.073898 | noble | Label: ubuntu-noble-uefi 2026-02-23 13:49:48.073918 | noble | Product Name: OpenStack Nova 2026-02-23 13:49:48.073939 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe42:fcc2 2026-02-23 13:49:48.096488 | 2026-02-23 13:49:48.096601 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-23 13:49:48.664116 | noble -> localhost | changed 2026-02-23 13:49:48.680728 | 2026-02-23 13:49:48.680845 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-23 13:49:50.002211 | noble -> localhost | changed 2026-02-23 13:49:50.022742 | 2026-02-23 13:49:50.022877 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 13:49:50.280505 | noble -> localhost | ok 2026-02-23 13:49:50.287249 | 2026-02-23 13:49:50.287349 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 13:49:50.306017 | noble | ok 2026-02-23 13:49:50.322997 | noble | included: /var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 13:49:50.330573 | 2026-02-23 13:49:50.330663 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 13:49:53.109310 | noble -> localhost | Generating public/private rsa key pair. 2026-02-23 13:49:53.109488 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/f17ce19dfa5947a2a6251727a3741f70_id_rsa 2026-02-23 13:49:53.109524 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/f17ce19dfa5947a2a6251727a3741f70_id_rsa.pub 2026-02-23 13:49:53.109550 | noble -> localhost | The key fingerprint is: 2026-02-23 13:49:53.109577 | noble -> localhost | SHA256:gz623xRySD/UQTcYe+6lZy/DsATTSKVW28JARrQVq1w zuul-build-sshkey 2026-02-23 13:49:53.109601 | noble -> localhost | The key's randomart image is: 2026-02-23 13:49:53.109623 | noble -> localhost | +---[RSA 3072]----+ 2026-02-23 13:49:53.109645 | noble -> localhost | | +*oO+o | 2026-02-23 13:49:53.109674 | noble -> localhost | | ..O.B . | 2026-02-23 13:49:53.109696 | noble -> localhost | | ..=oE o | 2026-02-23 13:49:53.109717 | noble -> localhost | | o *+o.+ | 2026-02-23 13:49:53.109736 | noble -> localhost | | . S Bo . .| 2026-02-23 13:49:53.109764 | noble -> localhost | | . + oo. o | 2026-02-23 13:49:53.109784 | noble -> localhost | | + .. +o o| 2026-02-23 13:49:53.109804 | noble -> localhost | | . o o . +o.| 2026-02-23 13:49:53.109825 | noble -> localhost | | ... . o.| 2026-02-23 13:49:53.109844 | noble -> localhost | +----[SHA256]-----+ 2026-02-23 13:49:53.109896 | noble -> localhost | ok: Runtime: 0:00:02.330123 2026-02-23 13:49:53.117469 | 2026-02-23 13:49:53.117569 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 13:49:53.155845 | noble | ok 2026-02-23 13:49:53.166976 | noble | included: /var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 13:49:53.198612 | 2026-02-23 13:49:53.198719 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 13:49:53.221670 | noble | skipping: Conditional result was False 2026-02-23 13:49:53.229423 | 2026-02-23 13:49:53.229520 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 13:49:53.950634 | noble | changed 2026-02-23 13:49:53.958165 | 2026-02-23 13:49:53.958280 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 13:49:54.265335 | noble | ok 2026-02-23 13:49:54.273735 | 2026-02-23 13:49:54.273849 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 13:49:55.049414 | noble | changed 2026-02-23 13:49:55.058380 | 2026-02-23 13:49:55.058503 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 13:49:55.809560 | noble | changed 2026-02-23 13:49:55.822724 | 2026-02-23 13:49:55.822888 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 13:49:55.867197 | noble | skipping: Conditional result was False 2026-02-23 13:49:55.874427 | 2026-02-23 13:49:55.874562 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 13:49:56.514908 | noble -> localhost | changed 2026-02-23 13:49:56.531000 | 2026-02-23 13:49:56.531171 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 13:49:56.900536 | noble -> localhost | Identity added: /var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/f17ce19dfa5947a2a6251727a3741f70_id_rsa (zuul-build-sshkey) 2026-02-23 13:49:56.900898 | noble -> localhost | ok: Runtime: 0:00:00.017315 2026-02-23 13:49:56.913032 | 2026-02-23 13:49:56.913204 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 13:49:57.368998 | noble | ok 2026-02-23 13:49:57.375336 | 2026-02-23 13:49:57.375448 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 13:49:57.416030 | noble | skipping: Conditional result was False 2026-02-23 13:49:57.470134 | 2026-02-23 13:49:57.470275 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-23 13:49:57.920304 | noble | ok 2026-02-23 13:49:57.934385 | 2026-02-23 13:49:57.934521 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-23 13:49:57.965227 | noble | ok 2026-02-23 13:49:57.973332 | 2026-02-23 13:49:57.973457 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-23 13:49:58.280674 | noble -> localhost | ok 2026-02-23 13:49:58.288408 | 2026-02-23 13:49:58.288527 | TASK [validate-host : Collect information about the host] 2026-02-23 13:49:59.766902 | noble | ok 2026-02-23 13:49:59.785457 | 2026-02-23 13:49:59.785585 | TASK [validate-host : Sanitize hostname] 2026-02-23 13:49:59.849863 | noble | ok 2026-02-23 13:49:59.859649 | 2026-02-23 13:49:59.859786 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-23 13:50:00.439076 | noble -> localhost | changed 2026-02-23 13:50:00.446700 | 2026-02-23 13:50:00.446828 | TASK [validate-host : Collect information about zuul worker] 2026-02-23 13:50:00.941876 | noble | ok 2026-02-23 13:50:00.948799 | 2026-02-23 13:50:00.948929 | TASK [validate-host : Write out all zuul information for each host] 2026-02-23 13:50:01.567692 | noble -> localhost | changed 2026-02-23 13:50:01.586645 | 2026-02-23 13:50:01.586784 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-23 13:50:01.915601 | noble | ok 2026-02-23 13:50:01.924054 | 2026-02-23 13:50:01.924179 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-23 13:50:02.848269 | noble | changed: 2026-02-23 13:50:02.848476 | noble | cd+++++++++ src/ 2026-02-23 13:50:02.848510 | noble | cd+++++++++ src/github.com/ 2026-02-23 13:50:02.848535 | noble | cd+++++++++ src/github.com/osism/ 2026-02-23 13:50:02.848556 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-02-23 13:50:02.848576 | noble | localhost | ok: "/var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/logs" 2026-02-23 13:53:02.828695 | noble -> localhost | changed: "/var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/artifacts" 2026-02-23 13:53:03.119443 | noble -> localhost | changed: "/var/lib/zuul/builds/f17ce19dfa5947a2a6251727a3741f70/work/docs" 2026-02-23 13:53:03.146178 | 2026-02-23 13:53:03.146398 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-23 13:53:04.422295 | noble | changed: 2026-02-23 13:53:04.422514 | noble | .d..t...... ./ 2026-02-23 13:53:04.422547 | noble | >f+++++++++ osism-esp.log 2026-02-23 13:53:04.422592 | noble | changed: All items complete 2026-02-23 13:53:04.422618 | 2026-02-23 13:53:05.043511 | noble | changed: .d..t...... ./ 2026-02-23 13:53:05.700482 | noble | changed: .d..t...... ./ 2026-02-23 13:53:05.733439 | 2026-02-23 13:53:05.733576 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-23 13:53:06.251452 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.010657 2026-02-23 13:53:06.523971 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.010378 2026-02-23 13:53:06.534735 | 2026-02-23 13:53:06.534849 | PLAY RECAP 2026-02-23 13:53:06.534905 | noble | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-23 13:53:06.534930 | 2026-02-23 13:53:06.655899 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-02-23 13:53:06.656958 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-23 13:53:07.379542 | 2026-02-23 13:53:07.379706 | PLAY [Base post] 2026-02-23 13:53:07.394532 | 2026-02-23 13:53:07.394667 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-23 13:53:08.047581 | noble | changed 2026-02-23 13:53:08.056789 | 2026-02-23 13:53:08.056903 | PLAY RECAP 2026-02-23 13:53:08.056971 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 13:53:08.057091 | 2026-02-23 13:53:08.179350 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-23 13:53:08.180331 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-23 13:53:09.003504 | 2026-02-23 13:53:09.003672 | PLAY [Base post-logs] 2026-02-23 13:53:09.014534 | 2026-02-23 13:53:09.014663 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-23 13:53:09.482070 | localhost | changed 2026-02-23 13:53:09.500656 | 2026-02-23 13:53:09.500861 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-23 13:53:09.528340 | localhost | ok 2026-02-23 13:53:09.532961 | 2026-02-23 13:53:09.533110 | TASK [Set zuul-log-path fact] 2026-02-23 13:53:09.549531 | localhost | ok 2026-02-23 13:53:09.559549 | 2026-02-23 13:53:09.559697 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 13:53:09.597811 | localhost | ok 2026-02-23 13:53:09.605534 | 2026-02-23 13:53:09.605715 | TASK [upload-logs : Create log directories] 2026-02-23 13:53:10.132388 | localhost | changed 2026-02-23 13:53:10.135714 | 2026-02-23 13:53:10.135825 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-23 13:53:10.668118 | localhost -> localhost | ok: Runtime: 0:00:00.007261 2026-02-23 13:53:10.672279 | 2026-02-23 13:53:10.672393 | TASK [upload-logs : Upload logs to log server] 2026-02-23 13:53:11.247496 | localhost | Output suppressed because no_log was given 2026-02-23 13:53:11.250785 | 2026-02-23 13:53:11.251090 | LOOP [upload-logs : Compress console log and json output] 2026-02-23 13:53:11.305508 | localhost | skipping: Conditional result was False 2026-02-23 13:53:11.311499 | localhost | skipping: Conditional result was False 2026-02-23 13:53:11.323074 | 2026-02-23 13:53:11.323321 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-23 13:53:11.368205 | localhost | skipping: Conditional result was False 2026-02-23 13:53:11.368510 | 2026-02-23 13:53:11.373158 | localhost | skipping: Conditional result was False 2026-02-23 13:53:11.386406 | 2026-02-23 13:53:11.386666 | LOOP [upload-logs : Upload console log and json output]