2026-03-06 21:03:46.037274 | Job console starting 2026-03-06 21:03:46.060814 | Updating git repos 2026-03-06 21:03:46.085420 | Cloning repos into workspace 2026-03-06 21:03:46.137965 | Restoring repo states 2026-03-06 21:03:46.144396 | Merging changes 2026-03-06 21:03:46.621527 | Checking out repos 2026-03-06 21:03:46.663759 | Preparing playbooks 2026-03-06 21:03:47.280899 | Running Ansible setup 2026-03-06 21:03:52.838585 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-06 21:03:53.584201 | 2026-03-06 21:03:53.584382 | PLAY [Base pre] 2026-03-06 21:03:53.601416 | 2026-03-06 21:03:53.601558 | TASK [Setup log path fact] 2026-03-06 21:03:53.631822 | noble | ok 2026-03-06 21:03:53.649151 | 2026-03-06 21:03:53.649299 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-06 21:03:53.689347 | noble | ok 2026-03-06 21:03:53.701625 | 2026-03-06 21:03:53.701761 | TASK [emit-job-header : Print job information] 2026-03-06 21:03:53.742092 | # Job Information 2026-03-06 21:03:53.742279 | Ansible Version: 2.16.14 2026-03-06 21:03:53.742314 | Job: openstack-ironic-images-build-osism-ipa 2026-03-06 21:03:53.742347 | Pipeline: check 2026-03-06 21:03:53.742370 | Executor: 521e9411259a 2026-03-06 21:03:53.742391 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/183 2026-03-06 21:03:53.742413 | Event ID: 974545f0-199f-11f1-9602-16c0f5c14942 2026-03-06 21:03:53.749668 | 2026-03-06 21:03:53.749844 | LOOP [emit-job-header : Print node information] 2026-03-06 21:03:53.876928 | noble | ok: 2026-03-06 21:03:53.877228 | noble | # Node Information 2026-03-06 21:03:53.877289 | noble | Inventory Hostname: noble 2026-03-06 21:03:53.877334 | noble | Hostname: ubuntu 2026-03-06 21:03:53.877373 | noble | Username: zuul 2026-03-06 21:03:53.877410 | noble | Distro: Ubuntu 24.04 2026-03-06 21:03:53.877454 | noble | Provider: regiocloud-a 2026-03-06 21:03:53.877494 | noble | Region: 2026-03-06 21:03:53.877531 | noble | Label: ubuntu-noble-uefi 2026-03-06 21:03:53.877566 | noble | Product Name: OpenStack Nova 2026-03-06 21:03:53.877603 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecb:3f0a 2026-03-06 21:03:53.894270 | 2026-03-06 21:03:53.894413 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-06 21:03:54.374578 | noble -> localhost | changed 2026-03-06 21:03:54.382978 | 2026-03-06 21:03:54.383121 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-06 21:03:55.409181 | noble -> localhost | changed 2026-03-06 21:03:55.433487 | 2026-03-06 21:03:55.433686 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-06 21:03:55.721476 | noble -> localhost | ok 2026-03-06 21:03:55.728696 | 2026-03-06 21:03:55.728817 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-06 21:03:55.757980 | noble | ok 2026-03-06 21:03:55.774343 | noble | included: /var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-06 21:03:55.782254 | 2026-03-06 21:03:55.782352 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-06 21:03:58.154002 | noble -> localhost | Generating public/private rsa key pair. 2026-03-06 21:03:58.154326 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/58b0163a935240658f18ad42c211c00c_id_rsa 2026-03-06 21:03:58.154371 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/58b0163a935240658f18ad42c211c00c_id_rsa.pub 2026-03-06 21:03:58.154398 | noble -> localhost | The key fingerprint is: 2026-03-06 21:03:58.154427 | noble -> localhost | SHA256:akQCiF6BH5uFKAYXW5T3cWXmVv5q1UPtIBU9/UwE5HQ zuul-build-sshkey 2026-03-06 21:03:58.154450 | noble -> localhost | The key's randomart image is: 2026-03-06 21:03:58.154471 | noble -> localhost | +---[RSA 3072]----+ 2026-03-06 21:03:58.154493 | noble -> localhost | |+.*+=. .+.B=E| 2026-03-06 21:03:58.154530 | noble -> localhost | |+= B... . .+ * o=| 2026-03-06 21:03:58.154551 | noble -> localhost | |+ + *... o + +++| 2026-03-06 21:03:58.154571 | noble -> localhost | | . + o . . ..++| 2026-03-06 21:03:58.154590 | noble -> localhost | | . S .=| 2026-03-06 21:03:58.154618 | noble -> localhost | | . . o.| 2026-03-06 21:03:58.154639 | noble -> localhost | | o o | 2026-03-06 21:03:58.154676 | noble -> localhost | | . . | 2026-03-06 21:03:58.154699 | noble -> localhost | | | 2026-03-06 21:03:58.154719 | noble -> localhost | +----[SHA256]-----+ 2026-03-06 21:03:58.154789 | noble -> localhost | ok: Runtime: 0:00:01.876916 2026-03-06 21:03:58.163533 | 2026-03-06 21:03:58.163717 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-06 21:03:58.195309 | noble | ok 2026-03-06 21:03:58.206132 | noble | included: /var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-06 21:03:58.215611 | 2026-03-06 21:03:58.215755 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-06 21:03:58.240323 | noble | skipping: Conditional result was False 2026-03-06 21:03:58.249461 | 2026-03-06 21:03:58.249569 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-06 21:03:58.885654 | noble | changed 2026-03-06 21:03:58.895824 | 2026-03-06 21:03:58.895976 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-06 21:03:59.223650 | noble | ok 2026-03-06 21:03:59.238654 | 2026-03-06 21:03:59.238900 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-06 21:04:00.033473 | noble | changed 2026-03-06 21:04:00.043139 | 2026-03-06 21:04:00.043281 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-06 21:04:00.826172 | noble | changed 2026-03-06 21:04:00.836279 | 2026-03-06 21:04:00.836531 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-06 21:04:00.864146 | noble | skipping: Conditional result was False 2026-03-06 21:04:00.878902 | 2026-03-06 21:04:00.879055 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-06 21:04:01.319842 | noble -> localhost | changed 2026-03-06 21:04:01.340819 | 2026-03-06 21:04:01.340954 | TASK [add-build-sshkey : Add back temp key] 2026-03-06 21:04:01.690459 | noble -> localhost | Identity added: /var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/58b0163a935240658f18ad42c211c00c_id_rsa (zuul-build-sshkey) 2026-03-06 21:04:01.690754 | noble -> localhost | ok: Runtime: 0:00:00.018005 2026-03-06 21:04:01.699637 | 2026-03-06 21:04:01.699776 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-06 21:04:02.134377 | noble | ok 2026-03-06 21:04:02.144339 | 2026-03-06 21:04:02.144480 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-06 21:04:02.169002 | noble | skipping: Conditional result was False 2026-03-06 21:04:02.227745 | 2026-03-06 21:04:02.227888 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-06 21:04:02.662992 | noble | ok 2026-03-06 21:04:02.677424 | 2026-03-06 21:04:02.677542 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-06 21:04:02.722367 | noble | ok 2026-03-06 21:04:02.733022 | 2026-03-06 21:04:02.733142 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-06 21:04:03.022923 | noble -> localhost | ok 2026-03-06 21:04:03.039043 | 2026-03-06 21:04:03.039193 | TASK [validate-host : Collect information about the host] 2026-03-06 21:04:04.431708 | noble | ok 2026-03-06 21:04:04.449744 | 2026-03-06 21:04:04.449872 | TASK [validate-host : Sanitize hostname] 2026-03-06 21:04:04.514972 | noble | ok 2026-03-06 21:04:04.523125 | 2026-03-06 21:04:04.523264 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-06 21:04:05.064107 | noble -> localhost | changed 2026-03-06 21:04:05.075970 | 2026-03-06 21:04:05.076128 | TASK [validate-host : Collect information about zuul worker] 2026-03-06 21:04:05.568143 | noble | ok 2026-03-06 21:04:05.576684 | 2026-03-06 21:04:05.576835 | TASK [validate-host : Write out all zuul information for each host] 2026-03-06 21:04:06.137030 | noble -> localhost | changed 2026-03-06 21:04:06.157980 | 2026-03-06 21:04:06.158131 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-06 21:04:06.455656 | noble | ok 2026-03-06 21:04:06.464774 | 2026-03-06 21:04:06.464929 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-06 21:04:07.412984 | noble | changed: 2026-03-06 21:04:07.413260 | noble | cd+++++++++ src/ 2026-03-06 21:04:07.413312 | noble | cd+++++++++ src/github.com/ 2026-03-06 21:04:07.413349 | noble | cd+++++++++ src/github.com/osism/ 2026-03-06 21:04:07.413380 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-03-06 21:04:07.413409 | noble | localhost | ok: "/var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/logs" 2026-03-06 21:09:33.215450 | noble -> localhost | changed: "/var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/artifacts" 2026-03-06 21:09:33.459649 | noble -> localhost | changed: "/var/lib/zuul/builds/58b0163a935240658f18ad42c211c00c/work/docs" 2026-03-06 21:09:33.476839 | 2026-03-06 21:09:33.476948 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-06 21:09:34.645092 | noble | changed: 2026-03-06 21:09:34.645388 | noble | .d..t...... ./ 2026-03-06 21:09:34.645448 | noble | >f+++++++++ osism-ipa.log 2026-03-06 21:09:34.645519 | noble | changed: All items complete 2026-03-06 21:09:34.645567 | 2026-03-06 21:09:35.262920 | noble | changed: .d..t...... ./ 2026-03-06 21:09:35.877375 | noble | changed: .d..t...... ./ 2026-03-06 21:09:35.893534 | 2026-03-06 21:09:35.893631 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-06 21:09:36.365223 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.009588 2026-03-06 21:09:36.638523 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.007597 2026-03-06 21:09:36.648675 | 2026-03-06 21:09:36.648748 | PLAY RECAP 2026-03-06 21:09:36.648796 | noble | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-06 21:09:36.648820 | 2026-03-06 21:09:36.737242 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-03-06 21:09:36.738243 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-06 21:09:37.498059 | 2026-03-06 21:09:37.498232 | PLAY [Base post] 2026-03-06 21:09:37.513064 | 2026-03-06 21:09:37.513213 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-06 21:09:38.119221 | noble | changed 2026-03-06 21:09:38.128820 | 2026-03-06 21:09:38.128932 | PLAY RECAP 2026-03-06 21:09:38.129020 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-06 21:09:38.129098 | 2026-03-06 21:09:38.212218 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-06 21:09:38.213041 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-06 21:09:38.933388 | 2026-03-06 21:09:38.933566 | PLAY [Base post-logs] 2026-03-06 21:09:38.945077 | 2026-03-06 21:09:38.945227 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-06 21:09:39.372442 | localhost | changed 2026-03-06 21:09:39.390537 | 2026-03-06 21:09:39.390738 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-06 21:09:39.430301 | localhost | ok 2026-03-06 21:09:39.437821 | 2026-03-06 21:09:39.438111 | TASK [Set zuul-log-path fact] 2026-03-06 21:09:39.468273 | localhost | ok 2026-03-06 21:09:39.484847 | 2026-03-06 21:09:39.485136 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-06 21:09:39.523845 | localhost | ok 2026-03-06 21:09:39.531081 | 2026-03-06 21:09:39.531261 | TASK [upload-logs : Create log directories] 2026-03-06 21:09:40.050601 | localhost | changed 2026-03-06 21:09:40.055261 | 2026-03-06 21:09:40.055426 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-06 21:09:40.505833 | localhost -> localhost | ok: Runtime: 0:00:00.006689 2026-03-06 21:09:40.513596 | 2026-03-06 21:09:40.513743 | TASK [upload-logs : Upload logs to log server] 2026-03-06 21:09:41.016260 | localhost | Output suppressed because no_log was given 2026-03-06 21:09:41.018869 | 2026-03-06 21:09:41.019043 | LOOP [upload-logs : Compress console log and json output] 2026-03-06 21:09:41.067120 | localhost | skipping: Conditional result was False 2026-03-06 21:09:41.071647 | localhost | skipping: Conditional result was False 2026-03-06 21:09:41.078557 | 2026-03-06 21:09:41.078881 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-06 21:09:41.124963 | localhost | skipping: Conditional result was False 2026-03-06 21:09:41.125628 | 2026-03-06 21:09:41.128769 | localhost | skipping: Conditional result was False 2026-03-06 21:09:41.141783 | 2026-03-06 21:09:41.142033 | LOOP [upload-logs : Upload console log and json output]