2026-09-27 17:49:43.713696 | Job console starting 2026-09-27 17:49:43.724741 | Updating git repos 2026-09-27 17:49:43.766426 | Cloning repos into workspace 2026-09-27 17:49:43.806863 | Restoring repo states 2026-09-27 17:49:43.816474 | Merging changes 2026-09-27 17:49:44.422380 | Checking out repos 2026-09-27 17:49:44.485915 | Preparing playbooks 2026-09-27 17:49:45.902020 | Running Ansible setup 2026-09-27 17:49:53.363920 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-27 17:49:54.156396 | 2026-09-27 17:49:54.156518 | PLAY [Base pre] 2026-09-27 17:49:54.177044 | 2026-09-27 17:49:54.177172 | TASK [Setup log path fact] 2026-09-27 17:49:54.206117 | noble | ok 2026-09-27 17:49:54.234878 | 2026-09-27 17:49:54.235003 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 17:49:54.273399 | noble | ok 2026-09-27 17:49:54.287812 | 2026-09-27 17:49:54.287909 | TASK [emit-job-header : Print job information] 2026-09-27 17:49:54.346679 | # Job Information 2026-09-27 17:49:54.346830 | Ansible Version: 2.16.14 2026-09-27 17:49:54.346864 | Job: openstack-ironic-images-build-osism-esp 2026-09-27 17:49:54.346895 | Pipeline: check 2026-09-27 17:49:54.346918 | Executor: 521e9411259a 2026-09-27 17:49:54.346938 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/223 2026-09-27 17:49:54.346960 | Event ID: 62ea1040-ba9b-11f1-8190-977f81dd5f3f 2026-09-27 17:49:54.352303 | 2026-09-27 17:49:54.352390 | LOOP [emit-job-header : Print node information] 2026-09-27 17:49:54.486111 | noble | ok: 2026-09-27 17:49:54.486246 | noble | # Node Information 2026-09-27 17:49:54.486274 | noble | Inventory Hostname: noble 2026-09-27 17:49:54.486294 | noble | Hostname: ubuntu 2026-09-27 17:49:54.486312 | noble | Username: zuul 2026-09-27 17:49:54.486329 | noble | Distro: Ubuntu 24.04 2026-09-27 17:49:54.486348 | noble | Provider: regiocloud-a 2026-09-27 17:49:54.486365 | noble | Region: 2026-09-27 17:49:54.486382 | noble | Label: ubuntu-noble-uefi 2026-09-27 17:49:54.486399 | noble | Product Name: OpenStack Nova 2026-09-27 17:49:54.486416 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe65:3301 2026-09-27 17:49:54.501863 | 2026-09-27 17:49:54.501963 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-27 17:49:54.940466 | noble -> localhost | changed 2026-09-27 17:49:54.948922 | 2026-09-27 17:49:54.949021 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-27 17:49:56.267200 | noble -> localhost | changed 2026-09-27 17:49:56.293631 | 2026-09-27 17:49:56.293758 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-27 17:49:56.510647 | noble -> localhost | ok 2026-09-27 17:49:56.520406 | 2026-09-27 17:49:56.520535 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-27 17:49:56.549136 | noble | ok 2026-09-27 17:49:56.567387 | noble | included: /var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-27 17:49:56.574127 | 2026-09-27 17:49:56.574203 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-27 17:49:57.973211 | noble -> localhost | Generating public/private rsa key pair. 2026-09-27 17:49:57.973764 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/8ddef13437e4429fa67dc56e6d64f056_id_rsa 2026-09-27 17:49:57.973877 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/8ddef13437e4429fa67dc56e6d64f056_id_rsa.pub 2026-09-27 17:49:57.973949 | noble -> localhost | The key fingerprint is: 2026-09-27 17:49:57.974012 | noble -> localhost | SHA256:tvGvxafJ6HY68GjHnELOl9tk5iyBTMQ5I5PWHi422wE zuul-build-sshkey 2026-09-27 17:49:57.974069 | noble -> localhost | The key's randomart image is: 2026-09-27 17:49:57.974144 | noble -> localhost | +---[RSA 3072]----+ 2026-09-27 17:49:57.974199 | noble -> localhost | | + . | 2026-09-27 17:49:57.974275 | noble -> localhost | | E O | 2026-09-27 17:49:57.974331 | noble -> localhost | | . B + | 2026-09-27 17:49:57.974379 | noble -> localhost | | + = | 2026-09-27 17:49:57.974429 | noble -> localhost | | . BSo | 2026-09-27 17:49:57.974487 | noble -> localhost | | ..*+.. | 2026-09-27 17:49:57.974540 | noble -> localhost | | +.*.+* . | 2026-09-27 17:49:57.974591 | noble -> localhost | | * %%.+ | 2026-09-27 17:49:57.974643 | noble -> localhost | | . **BO | 2026-09-27 17:49:57.974693 | noble -> localhost | +----[SHA256]-----+ 2026-09-27 17:49:57.975858 | noble -> localhost | ok: Runtime: 0:00:00.957555 2026-09-27 17:49:57.983920 | 2026-09-27 17:49:57.984002 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-27 17:49:58.012159 | noble | ok 2026-09-27 17:49:58.022290 | noble | included: /var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-27 17:49:58.033883 | 2026-09-27 17:49:58.033960 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-27 17:49:58.047252 | noble | skipping: Conditional result was False 2026-09-27 17:49:58.053636 | 2026-09-27 17:49:58.053713 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-27 17:49:58.730367 | noble | changed 2026-09-27 17:49:58.738780 | 2026-09-27 17:49:58.738950 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-27 17:49:59.063834 | noble | ok 2026-09-27 17:49:59.075817 | 2026-09-27 17:49:59.075922 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-27 17:49:59.896987 | noble | changed 2026-09-27 17:49:59.903176 | 2026-09-27 17:49:59.903276 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-27 17:50:00.820291 | noble | changed 2026-09-27 17:50:00.831798 | 2026-09-27 17:50:00.831908 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-27 17:50:00.864677 | noble | skipping: Conditional result was False 2026-09-27 17:50:00.871137 | 2026-09-27 17:50:00.871232 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-27 17:50:01.339267 | noble -> localhost | changed 2026-09-27 17:50:01.351372 | 2026-09-27 17:50:01.351462 | TASK [add-build-sshkey : Add back temp key] 2026-09-27 17:50:01.647792 | noble -> localhost | Identity added: /var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/8ddef13437e4429fa67dc56e6d64f056_id_rsa (zuul-build-sshkey) 2026-09-27 17:50:01.648285 | noble -> localhost | ok: Runtime: 0:00:00.015892 2026-09-27 17:50:01.664165 | 2026-09-27 17:50:01.664353 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-27 17:50:02.129291 | noble | ok 2026-09-27 17:50:02.145802 | 2026-09-27 17:50:02.145987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-27 17:50:02.170994 | noble | skipping: Conditional result was False 2026-09-27 17:50:02.207105 | 2026-09-27 17:50:02.207200 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-27 17:50:02.642936 | noble | ok 2026-09-27 17:50:02.654173 | 2026-09-27 17:50:02.654265 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-27 17:50:02.683630 | noble | ok 2026-09-27 17:50:02.689122 | 2026-09-27 17:50:02.689209 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-27 17:50:02.975004 | noble -> localhost | ok 2026-09-27 17:50:02.981908 | 2026-09-27 17:50:02.981996 | TASK [validate-host : Collect information about the host] 2026-09-27 17:50:04.460539 | noble | ok 2026-09-27 17:50:04.473587 | 2026-09-27 17:50:04.473676 | TASK [validate-host : Sanitize hostname] 2026-09-27 17:50:04.521770 | noble | ok 2026-09-27 17:50:04.527070 | 2026-09-27 17:50:04.527186 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-27 17:50:05.101253 | noble -> localhost | changed 2026-09-27 17:50:05.107279 | 2026-09-27 17:50:05.107364 | TASK [validate-host : Collect information about zuul worker] 2026-09-27 17:50:05.604736 | noble | ok 2026-09-27 17:50:05.612028 | 2026-09-27 17:50:05.612182 | TASK [validate-host : Write out all zuul information for each host] 2026-09-27 17:50:06.154797 | noble -> localhost | changed 2026-09-27 17:50:06.167061 | 2026-09-27 17:50:06.167177 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-27 17:50:06.493197 | noble | ok 2026-09-27 17:50:06.500796 | 2026-09-27 17:50:06.500900 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-27 17:50:07.359679 | noble | changed: 2026-09-27 17:50:07.359841 | noble | cd+++++++++ src/ 2026-09-27 17:50:07.359876 | noble | cd+++++++++ src/github.com/ 2026-09-27 17:50:07.359901 | noble | cd+++++++++ src/github.com/osism/ 2026-09-27 17:50:07.359922 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-09-27 17:50:07.359942 | noble | localhost | ok: "/var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/logs" 2026-09-27 17:53:50.308773 | noble -> localhost | changed: "/var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/artifacts" 2026-09-27 17:53:50.576914 | noble -> localhost | changed: "/var/lib/zuul/builds/8ddef13437e4429fa67dc56e6d64f056/work/docs" 2026-09-27 17:53:50.603548 | 2026-09-27 17:53:50.603700 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-27 17:53:52.034783 | noble | changed: 2026-09-27 17:53:52.035123 | noble | .d..t...... ./ 2026-09-27 17:53:52.035185 | noble | >f+++++++++ net-debug.post.txt 2026-09-27 17:53:52.035229 | noble | >f+++++++++ net-debug.pre.txt 2026-09-27 17:53:52.035266 | noble | >f+++++++++ osism-esp.log 2026-09-27 17:53:52.035313 | noble | >f+++++++++ sudo-debug.txt 2026-09-27 17:53:52.035349 | noble | >f+++++++++ sudo-strace.log 2026-09-27 17:53:52.035382 | noble | >f+++++++++ sudo-strace.log.time 2026-09-27 17:53:52.035440 | noble | changed: All items complete 2026-09-27 17:53:52.035483 | 2026-09-27 17:53:52.718079 | noble | changed: .d..t...... ./ 2026-09-27 17:53:53.371438 | noble | changed: .d..t...... ./ 2026-09-27 17:53:53.404725 | 2026-09-27 17:53:53.404857 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-27 17:53:53.759201 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008254 2026-09-27 17:53:54.061905 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.009774 2026-09-27 17:53:54.088355 | 2026-09-27 17:53:54.088522 | PLAY RECAP 2026-09-27 17:53:54.088663 | noble | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-27 17:53:54.088725 | 2026-09-27 17:53:54.215212 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-27 17:53:54.217354 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 17:53:54.955881 | 2026-09-27 17:53:54.956028 | PLAY [Base post] 2026-09-27 17:53:54.970225 | 2026-09-27 17:53:54.970355 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-27 17:53:55.640283 | noble | changed 2026-09-27 17:53:55.652758 | 2026-09-27 17:53:55.652924 | PLAY RECAP 2026-09-27 17:53:55.653025 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-27 17:53:55.653127 | 2026-09-27 17:53:55.776289 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 17:53:55.778680 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-27 17:53:56.570402 | 2026-09-27 17:53:56.570580 | PLAY [Base post-logs] 2026-09-27 17:53:56.581158 | 2026-09-27 17:53:56.581287 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-27 17:53:57.048146 | localhost | changed 2026-09-27 17:53:57.064242 | 2026-09-27 17:53:57.064452 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-27 17:53:57.090930 | localhost | ok 2026-09-27 17:53:57.094813 | 2026-09-27 17:53:57.094922 | TASK [Set zuul-log-path fact] 2026-09-27 17:53:57.112215 | localhost | ok 2026-09-27 17:53:57.129028 | 2026-09-27 17:53:57.129193 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 17:53:57.157103 | localhost | ok 2026-09-27 17:53:57.164491 | 2026-09-27 17:53:57.164771 | TASK [upload-logs : Create log directories] 2026-09-27 17:53:57.650179 | localhost | changed 2026-09-27 17:53:57.653808 | 2026-09-27 17:53:57.653937 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-27 17:53:58.144178 | localhost -> localhost | ok: Runtime: 0:00:00.004348 2026-09-27 17:53:58.149205 | 2026-09-27 17:53:58.149333 | TASK [upload-logs : Upload logs to log server] 2026-09-27 17:53:58.714656 | localhost | Output suppressed because no_log was given 2026-09-27 17:53:58.717881 | 2026-09-27 17:53:58.718035 | LOOP [upload-logs : Compress console log and json output] 2026-09-27 17:53:58.775994 | localhost | skipping: Conditional result was False 2026-09-27 17:53:58.780424 | localhost | skipping: Conditional result was False 2026-09-27 17:53:58.794851 | 2026-09-27 17:53:58.795104 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-27 17:53:58.851942 | localhost | skipping: Conditional result was False 2026-09-27 17:53:58.852694 | 2026-09-27 17:53:58.856794 | localhost | skipping: Conditional result was False 2026-09-27 17:53:58.866716 | 2026-09-27 17:53:58.866902 | LOOP [upload-logs : Upload console log and json output]