2026-01-17 06:02:59.039553 | Job console starting 2026-01-17 06:02:59.054886 | Updating git repos 2026-01-17 06:02:59.073858 | Cloning repos into workspace 2026-01-17 06:02:59.105274 | Restoring repo states 2026-01-17 06:02:59.110587 | Merging changes 2026-01-17 06:02:59.110602 | Checking out repos 2026-01-17 06:02:59.140849 | Preparing playbooks 2026-01-17 06:02:59.644184 | Running Ansible setup 2026-01-17 06:03:05.320587 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-17 06:03:06.104287 | 2026-01-17 06:03:06.104494 | PLAY [Base pre] 2026-01-17 06:03:06.122536 | 2026-01-17 06:03:06.122692 | TASK [Setup log path fact] 2026-01-17 06:03:06.152731 | noble | ok 2026-01-17 06:03:06.170209 | 2026-01-17 06:03:06.170354 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-17 06:03:06.211760 | noble | ok 2026-01-17 06:03:06.225885 | 2026-01-17 06:03:06.226018 | TASK [emit-job-header : Print job information] 2026-01-17 06:03:06.283911 | # Job Information 2026-01-17 06:03:06.284229 | Ansible Version: 2.16.14 2026-01-17 06:03:06.284306 | Job: openstack-ironic-images-publish-osism-node 2026-01-17 06:03:06.284374 | Pipeline: periodic-weekly 2026-01-17 06:03:06.284487 | Executor: 521e9411259a 2026-01-17 06:03:06.284533 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-01-17 06:03:06.284579 | Event ID: c9abb572b9ef4d56b09fbe3bd2aa0bfc 2026-01-17 06:03:06.296107 | 2026-01-17 06:03:06.296254 | LOOP [emit-job-header : Print node information] 2026-01-17 06:03:06.429791 | noble | ok: 2026-01-17 06:03:06.429991 | noble | # Node Information 2026-01-17 06:03:06.430027 | noble | Inventory Hostname: noble 2026-01-17 06:03:06.430054 | noble | Hostname: ubuntu 2026-01-17 06:03:06.430077 | noble | Username: zuul 2026-01-17 06:03:06.430099 | noble | Distro: Ubuntu 24.04 2026-01-17 06:03:06.430123 | noble | Provider: regiocloud-a 2026-01-17 06:03:06.430144 | noble | Region: 2026-01-17 06:03:06.430166 | noble | Label: ubuntu-noble-uefi 2026-01-17 06:03:06.430188 | noble | Product Name: OpenStack Nova 2026-01-17 06:03:06.430210 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4b:8e11 2026-01-17 06:03:06.453938 | 2026-01-17 06:03:06.454076 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-17 06:03:07.045544 | noble -> localhost | changed 2026-01-17 06:03:07.053891 | 2026-01-17 06:03:07.054025 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-17 06:03:08.106105 | noble -> localhost | changed 2026-01-17 06:03:08.120726 | 2026-01-17 06:03:08.120870 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-17 06:03:08.388288 | noble -> localhost | ok 2026-01-17 06:03:08.395722 | 2026-01-17 06:03:08.395860 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-17 06:03:08.425459 | noble | ok 2026-01-17 06:03:08.442620 | noble | included: /var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-17 06:03:08.452508 | 2026-01-17 06:03:08.452641 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-17 06:03:09.463985 | noble -> localhost | Generating public/private rsa key pair. 2026-01-17 06:03:09.464216 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/c13e21add14d4938af041e7c966db957_id_rsa 2026-01-17 06:03:09.464255 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/c13e21add14d4938af041e7c966db957_id_rsa.pub 2026-01-17 06:03:09.464281 | noble -> localhost | The key fingerprint is: 2026-01-17 06:03:09.464309 | noble -> localhost | SHA256:i+53EV2AznZzUVvgiKG8kGvZz0wIKvpZYp6MssWXGIQ zuul-build-sshkey 2026-01-17 06:03:09.464333 | noble -> localhost | The key's randomart image is: 2026-01-17 06:03:09.464355 | noble -> localhost | +---[RSA 3072]----+ 2026-01-17 06:03:09.464376 | noble -> localhost | | .....oo| 2026-01-17 06:03:09.464456 | noble -> localhost | | . o ..o oo o| 2026-01-17 06:03:09.464481 | noble -> localhost | |E . + oo.....o | 2026-01-17 06:03:09.464502 | noble -> localhost | | . . * o= + . | 2026-01-17 06:03:09.464523 | noble -> localhost | | o . + S..o o | 2026-01-17 06:03:09.464549 | noble -> localhost | | o + o . *. | 2026-01-17 06:03:09.464571 | noble -> localhost | |. * + . . +. | 2026-01-17 06:03:09.464591 | noble -> localhost | |.B * . . . | 2026-01-17 06:03:09.464613 | noble -> localhost | |+.* .o. . | 2026-01-17 06:03:09.464633 | noble -> localhost | +----[SHA256]-----+ 2026-01-17 06:03:09.464686 | noble -> localhost | ok: Runtime: 0:00:00.503405 2026-01-17 06:03:09.472461 | 2026-01-17 06:03:09.472592 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-17 06:03:09.502096 | noble | ok 2026-01-17 06:03:09.513784 | noble | included: /var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-17 06:03:09.524006 | 2026-01-17 06:03:09.524119 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-17 06:03:09.547943 | noble | skipping: Conditional result was False 2026-01-17 06:03:09.556591 | 2026-01-17 06:03:09.556709 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-17 06:03:10.179931 | noble | changed 2026-01-17 06:03:10.186966 | 2026-01-17 06:03:10.187145 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-17 06:03:10.490154 | noble | ok 2026-01-17 06:03:10.496796 | 2026-01-17 06:03:10.496922 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-17 06:03:11.283155 | noble | changed 2026-01-17 06:03:11.299639 | 2026-01-17 06:03:11.299779 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-17 06:03:12.106508 | noble | changed 2026-01-17 06:03:12.114940 | 2026-01-17 06:03:12.115066 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-17 06:03:12.139464 | noble | skipping: Conditional result was False 2026-01-17 06:03:12.147143 | 2026-01-17 06:03:12.147265 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-17 06:03:12.582991 | noble -> localhost | changed 2026-01-17 06:03:12.604182 | 2026-01-17 06:03:12.604318 | TASK [add-build-sshkey : Add back temp key] 2026-01-17 06:03:12.925462 | noble -> localhost | Identity added: /var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/c13e21add14d4938af041e7c966db957_id_rsa (zuul-build-sshkey) 2026-01-17 06:03:12.925763 | noble -> localhost | ok: Runtime: 0:00:00.011036 2026-01-17 06:03:12.933424 | 2026-01-17 06:03:12.933547 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-17 06:03:13.393664 | noble | ok 2026-01-17 06:03:13.400215 | 2026-01-17 06:03:13.400341 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-17 06:03:13.424842 | noble | skipping: Conditional result was False 2026-01-17 06:03:13.479693 | 2026-01-17 06:03:13.479819 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-17 06:03:13.928871 | noble | ok 2026-01-17 06:03:13.940634 | 2026-01-17 06:03:13.940753 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-17 06:03:13.989164 | noble | ok 2026-01-17 06:03:13.999778 | 2026-01-17 06:03:13.999908 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-17 06:03:14.307676 | noble -> localhost | ok 2026-01-17 06:03:14.315757 | 2026-01-17 06:03:14.315895 | TASK [validate-host : Collect information about the host] 2026-01-17 06:03:15.748000 | noble | ok 2026-01-17 06:03:15.765179 | 2026-01-17 06:03:15.765312 | TASK [validate-host : Sanitize hostname] 2026-01-17 06:03:15.831741 | noble | ok 2026-01-17 06:03:15.840058 | 2026-01-17 06:03:15.840194 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-17 06:03:16.422817 | noble -> localhost | changed 2026-01-17 06:03:16.429854 | 2026-01-17 06:03:16.429977 | TASK [validate-host : Collect information about zuul worker] 2026-01-17 06:03:16.922915 | noble | ok 2026-01-17 06:03:16.931824 | 2026-01-17 06:03:16.931977 | TASK [validate-host : Write out all zuul information for each host] 2026-01-17 06:03:17.482335 | noble -> localhost | changed 2026-01-17 06:03:17.493618 | 2026-01-17 06:03:17.493739 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-17 06:03:17.859807 | noble | ok 2026-01-17 06:03:17.869707 | 2026-01-17 06:03:17.869842 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-17 06:03:18.795438 | noble | changed: 2026-01-17 06:03:18.795780 | noble | cd+++++++++ src/ 2026-01-17 06:03:18.795840 | noble | cd+++++++++ src/github.com/ 2026-01-17 06:03:18.795878 | noble | cd+++++++++ src/github.com/osism/ 2026-01-17 06:03:18.795913 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-01-17 06:03:18.795946 | noble | localhost | ok: "/var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/logs" 2026-01-17 06:17:45.672377 | noble -> localhost | changed: "/var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/artifacts" 2026-01-17 06:17:45.942569 | noble -> localhost | changed: "/var/lib/zuul/builds/c13e21add14d4938af041e7c966db957/work/docs" 2026-01-17 06:17:45.968636 | 2026-01-17 06:17:45.968798 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-17 06:17:47.308869 | noble | changed: 2026-01-17 06:17:47.309201 | noble | .d..t...... ./ 2026-01-17 06:17:47.309267 | noble | >f+++++++++ osism-node.log 2026-01-17 06:17:47.309360 | noble | changed: All items complete 2026-01-17 06:17:47.309408 | 2026-01-17 06:17:47.983137 | noble | changed: .d..t...... ./ 2026-01-17 06:17:48.632029 | noble | changed: .d..t...... ./ 2026-01-17 06:17:48.655270 | 2026-01-17 06:17:48.655415 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-17 06:17:48.689053 | noble | skipping: Conditional result was False 2026-01-17 06:17:48.691915 | noble | skipping: Conditional result was False 2026-01-17 06:17:48.713930 | 2026-01-17 06:17:48.714050 | PLAY RECAP 2026-01-17 06:17:48.714230 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-01-17 06:17:48.714313 | 2026-01-17 06:17:48.843606 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-01-17 06:17:48.845971 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-17 06:17:49.572019 | 2026-01-17 06:17:49.572211 | PLAY [Base post] 2026-01-17 06:17:49.587272 | 2026-01-17 06:17:49.587412 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-17 06:17:50.240340 | noble | changed 2026-01-17 06:17:50.252196 | 2026-01-17 06:17:50.252341 | PLAY RECAP 2026-01-17 06:17:50.252430 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-17 06:17:50.252515 | 2026-01-17 06:17:50.375573 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-17 06:17:50.376542 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-17 06:17:51.158984 | 2026-01-17 06:17:51.159176 | PLAY [Base post-logs] 2026-01-17 06:17:51.170458 | 2026-01-17 06:17:51.170600 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-17 06:17:51.636602 | localhost | changed 2026-01-17 06:17:51.655293 | 2026-01-17 06:17:51.655498 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-17 06:17:51.685026 | localhost | ok 2026-01-17 06:17:51.691856 | 2026-01-17 06:17:51.692028 | TASK [Set zuul-log-path fact] 2026-01-17 06:17:51.709684 | localhost | ok 2026-01-17 06:17:51.722496 | 2026-01-17 06:17:51.722638 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-17 06:17:51.748720 | localhost | ok 2026-01-17 06:17:51.753372 | 2026-01-17 06:17:51.753519 | TASK [upload-logs : Create log directories] 2026-01-17 06:17:52.252012 | localhost | changed 2026-01-17 06:17:52.256686 | 2026-01-17 06:17:52.256835 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-17 06:17:52.793447 | localhost -> localhost | ok: Runtime: 0:00:00.013974 2026-01-17 06:17:52.797854 | 2026-01-17 06:17:52.797984 | TASK [upload-logs : Upload logs to log server] 2026-01-17 06:17:53.363179 | localhost | Output suppressed because no_log was given 2026-01-17 06:17:53.367383 | 2026-01-17 06:17:53.367589 | LOOP [upload-logs : Compress console log and json output] 2026-01-17 06:17:53.420708 | localhost | skipping: Conditional result was False 2026-01-17 06:17:53.425864 | localhost | skipping: Conditional result was False 2026-01-17 06:17:53.439009 | 2026-01-17 06:17:53.439249 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-17 06:17:53.484584 | localhost | skipping: Conditional result was False 2026-01-17 06:17:53.485221 | 2026-01-17 06:17:53.488877 | localhost | skipping: Conditional result was False 2026-01-17 06:17:53.500574 | 2026-01-17 06:17:53.500789 | LOOP [upload-logs : Upload console log and json output]