2026-02-25 21:18:51.449514 | Job console starting 2026-02-25 21:18:51.461331 | Updating git repos 2026-02-25 21:18:51.485892 | Cloning repos into workspace 2026-02-25 21:18:51.538365 | Restoring repo states 2026-02-25 21:18:51.547959 | Merging changes 2026-02-25 21:18:52.149577 | Checking out repos 2026-02-25 21:18:52.180924 | Preparing playbooks 2026-02-25 21:18:52.882527 | Running Ansible setup 2026-02-25 21:18:58.912804 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-25 21:18:59.670002 | 2026-02-25 21:18:59.670289 | PLAY [Base pre] 2026-02-25 21:18:59.700733 | 2026-02-25 21:18:59.700918 | TASK [Setup log path fact] 2026-02-25 21:18:59.733331 | noble | ok 2026-02-25 21:18:59.752103 | 2026-02-25 21:18:59.752307 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 21:18:59.783340 | noble | ok 2026-02-25 21:18:59.795330 | 2026-02-25 21:18:59.795453 | TASK [emit-job-header : Print job information] 2026-02-25 21:18:59.855044 | # Job Information 2026-02-25 21:18:59.855411 | Ansible Version: 2.16.14 2026-02-25 21:18:59.855479 | Job: openstack-ironic-images-build-osism-ipa-stable 2026-02-25 21:18:59.855606 | Pipeline: check 2026-02-25 21:18:59.855653 | Executor: 521e9411259a 2026-02-25 21:18:59.855692 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/174 2026-02-25 21:18:59.855732 | Event ID: 169123f0-128f-11f1-8c25-3068b31a8d72 2026-02-25 21:18:59.866671 | 2026-02-25 21:18:59.866876 | LOOP [emit-job-header : Print node information] 2026-02-25 21:19:00.010163 | noble | ok: 2026-02-25 21:19:00.010436 | noble | # Node Information 2026-02-25 21:19:00.010479 | noble | Inventory Hostname: noble 2026-02-25 21:19:00.010510 | noble | Hostname: ubuntu 2026-02-25 21:19:00.010538 | noble | Username: zuul 2026-02-25 21:19:00.010562 | noble | Distro: Ubuntu 24.04 2026-02-25 21:19:00.010587 | noble | Provider: regiocloud-a 2026-02-25 21:19:00.010610 | noble | Region: 2026-02-25 21:19:00.010632 | noble | Label: ubuntu-noble-uefi 2026-02-25 21:19:00.010654 | noble | Product Name: OpenStack Nova 2026-02-25 21:19:00.010675 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:225e 2026-02-25 21:19:00.037686 | 2026-02-25 21:19:00.037853 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 21:19:00.525255 | noble -> localhost | changed 2026-02-25 21:19:00.543745 | 2026-02-25 21:19:00.543903 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 21:19:01.683011 | noble -> localhost | changed 2026-02-25 21:19:01.697445 | 2026-02-25 21:19:01.697581 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 21:19:01.985773 | noble -> localhost | ok 2026-02-25 21:19:01.993034 | 2026-02-25 21:19:01.993160 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 21:19:02.022759 | noble | ok 2026-02-25 21:19:02.039006 | noble | included: /var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 21:19:02.047072 | 2026-02-25 21:19:02.047183 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 21:19:03.537807 | noble -> localhost | Generating public/private rsa key pair. 2026-02-25 21:19:03.538362 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/003e5b45c4cc42e29406ee574b0262e0_id_rsa 2026-02-25 21:19:03.538459 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/003e5b45c4cc42e29406ee574b0262e0_id_rsa.pub 2026-02-25 21:19:03.538527 | noble -> localhost | The key fingerprint is: 2026-02-25 21:19:03.538588 | noble -> localhost | SHA256:fkH9XOQQWG5C2a7MBK31pLpc9daoLj2i42nQXokT7P0 zuul-build-sshkey 2026-02-25 21:19:03.538646 | noble -> localhost | The key's randomart image is: 2026-02-25 21:19:03.538702 | noble -> localhost | +---[RSA 3072]----+ 2026-02-25 21:19:03.538755 | noble -> localhost | | ..=+..| 2026-02-25 21:19:03.538907 | noble -> localhost | | .o=.o+ | 2026-02-25 21:19:03.538973 | noble -> localhost | | . .+o=o o| 2026-02-25 21:19:03.539027 | noble -> localhost | | o.. o=+. | 2026-02-25 21:19:03.539080 | noble -> localhost | | oS+.* ooo.| 2026-02-25 21:19:03.539147 | noble -> localhost | | ..= =.= . +| 2026-02-25 21:19:03.539201 | noble -> localhost | | o.+.= . . | 2026-02-25 21:19:03.539277 | noble -> localhost | | +o= E | 2026-02-25 21:19:03.539336 | noble -> localhost | | o+o +.. | 2026-02-25 21:19:03.539391 | noble -> localhost | +----[SHA256]-----+ 2026-02-25 21:19:03.539541 | noble -> localhost | ok: Runtime: 0:00:00.972735 2026-02-25 21:19:03.554454 | 2026-02-25 21:19:03.554639 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 21:19:03.592815 | noble | ok 2026-02-25 21:19:03.607149 | noble | included: /var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 21:19:03.616829 | 2026-02-25 21:19:03.616939 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 21:19:03.641984 | noble | skipping: Conditional result was False 2026-02-25 21:19:03.654708 | 2026-02-25 21:19:03.654907 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 21:19:04.295993 | noble | changed 2026-02-25 21:19:04.305078 | 2026-02-25 21:19:04.305218 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 21:19:04.624982 | noble | ok 2026-02-25 21:19:04.631734 | 2026-02-25 21:19:04.631858 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 21:19:05.444183 | noble | changed 2026-02-25 21:19:05.451271 | 2026-02-25 21:19:05.451393 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 21:19:06.263346 | noble | changed 2026-02-25 21:19:06.272006 | 2026-02-25 21:19:06.272145 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 21:19:06.297288 | noble | skipping: Conditional result was False 2026-02-25 21:19:06.306053 | 2026-02-25 21:19:06.306168 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 21:19:06.826725 | noble -> localhost | changed 2026-02-25 21:19:06.841571 | 2026-02-25 21:19:06.841704 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 21:19:07.234646 | noble -> localhost | Identity added: /var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/003e5b45c4cc42e29406ee574b0262e0_id_rsa (zuul-build-sshkey) 2026-02-25 21:19:07.235329 | noble -> localhost | ok: Runtime: 0:00:00.020226 2026-02-25 21:19:07.252458 | 2026-02-25 21:19:07.252720 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 21:19:07.725276 | noble | ok 2026-02-25 21:19:07.732442 | 2026-02-25 21:19:07.732553 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 21:19:07.766388 | noble | skipping: Conditional result was False 2026-02-25 21:19:07.813755 | 2026-02-25 21:19:07.813882 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 21:19:08.274635 | noble | ok 2026-02-25 21:19:08.288442 | 2026-02-25 21:19:08.288574 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-25 21:19:08.336219 | noble | ok 2026-02-25 21:19:08.346088 | 2026-02-25 21:19:08.346207 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-25 21:19:08.675575 | noble -> localhost | ok 2026-02-25 21:19:08.683815 | 2026-02-25 21:19:08.683931 | TASK [validate-host : Collect information about the host] 2026-02-25 21:19:10.129723 | noble | ok 2026-02-25 21:19:10.150865 | 2026-02-25 21:19:10.151014 | TASK [validate-host : Sanitize hostname] 2026-02-25 21:19:10.221820 | noble | ok 2026-02-25 21:19:10.232455 | 2026-02-25 21:19:10.232818 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-25 21:19:10.849125 | noble -> localhost | changed 2026-02-25 21:19:10.865401 | 2026-02-25 21:19:10.865572 | TASK [validate-host : Collect information about zuul worker] 2026-02-25 21:19:11.374748 | noble | ok 2026-02-25 21:19:11.384172 | 2026-02-25 21:19:11.384349 | TASK [validate-host : Write out all zuul information for each host] 2026-02-25 21:19:11.978278 | noble -> localhost | changed 2026-02-25 21:19:11.999459 | 2026-02-25 21:19:11.999591 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-25 21:19:12.340807 | noble | ok 2026-02-25 21:19:12.353206 | 2026-02-25 21:19:12.353736 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-25 21:19:13.340096 | noble | changed: 2026-02-25 21:19:13.340444 | noble | cd+++++++++ src/ 2026-02-25 21:19:13.340501 | noble | cd+++++++++ src/github.com/ 2026-02-25 21:19:13.340537 | noble | cd+++++++++ src/github.com/osism/ 2026-02-25 21:19:13.340567 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-02-25 21:19:13.340595 | noble | localhost | ok: "/var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/logs" 2026-02-25 21:25:35.324699 | noble -> localhost | changed: "/var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/artifacts" 2026-02-25 21:25:35.604610 | noble -> localhost | changed: "/var/lib/zuul/builds/003e5b45c4cc42e29406ee574b0262e0/work/docs" 2026-02-25 21:25:35.632455 | 2026-02-25 21:25:35.632639 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-25 21:25:36.968639 | noble | changed: 2026-02-25 21:25:36.968974 | noble | .d..t...... ./ 2026-02-25 21:25:36.969017 | noble | >f+++++++++ osism-ipa-stable.log 2026-02-25 21:25:36.969070 | noble | changed: All items complete 2026-02-25 21:25:36.969103 | 2026-02-25 21:25:37.649640 | noble | changed: .d..t...... ./ 2026-02-25 21:25:38.331493 | noble | changed: .d..t...... ./ 2026-02-25 21:25:38.358488 | 2026-02-25 21:25:38.358651 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-25 21:25:38.891911 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.012009 2026-02-25 21:25:39.193269 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.010096 2026-02-25 21:25:39.210296 | 2026-02-25 21:25:39.210426 | PLAY RECAP 2026-02-25 21:25:39.210491 | noble | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-25 21:25:39.210523 | 2026-02-25 21:25:39.331988 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-02-25 21:25:39.332957 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 21:25:40.093598 | 2026-02-25 21:25:40.093771 | PLAY [Base post] 2026-02-25 21:25:40.108629 | 2026-02-25 21:25:40.108788 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-25 21:25:40.759693 | noble | changed 2026-02-25 21:25:40.767491 | 2026-02-25 21:25:40.767604 | PLAY RECAP 2026-02-25 21:25:40.767680 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 21:25:40.767767 | 2026-02-25 21:25:40.895513 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 21:25:40.896480 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-25 21:25:41.722712 | 2026-02-25 21:25:41.722938 | PLAY [Base post-logs] 2026-02-25 21:25:41.749331 | 2026-02-25 21:25:41.749502 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 21:25:42.246603 | localhost | changed 2026-02-25 21:25:42.265193 | 2026-02-25 21:25:42.265389 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 21:25:42.293986 | localhost | ok 2026-02-25 21:25:42.300596 | 2026-02-25 21:25:42.300778 | TASK [Set zuul-log-path fact] 2026-02-25 21:25:42.319477 | localhost | ok 2026-02-25 21:25:42.332775 | 2026-02-25 21:25:42.332912 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 21:25:42.372930 | localhost | ok 2026-02-25 21:25:42.381558 | 2026-02-25 21:25:42.381777 | TASK [upload-logs : Create log directories] 2026-02-25 21:25:42.916911 | localhost | changed 2026-02-25 21:25:42.921914 | 2026-02-25 21:25:42.922074 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-25 21:25:43.441301 | localhost -> localhost | ok: Runtime: 0:00:00.004738 2026-02-25 21:25:43.450602 | 2026-02-25 21:25:43.450801 | TASK [upload-logs : Upload logs to log server] 2026-02-25 21:25:44.030302 | localhost | Output suppressed because no_log was given 2026-02-25 21:25:44.034736 | 2026-02-25 21:25:44.034985 | LOOP [upload-logs : Compress console log and json output] 2026-02-25 21:25:44.097178 | localhost | skipping: Conditional result was False 2026-02-25 21:25:44.102050 | localhost | skipping: Conditional result was False 2026-02-25 21:25:44.110457 | 2026-02-25 21:25:44.110748 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-25 21:25:44.159937 | localhost | skipping: Conditional result was False 2026-02-25 21:25:44.160634 | 2026-02-25 21:25:44.164042 | localhost | skipping: Conditional result was False 2026-02-25 21:25:44.178430 | 2026-02-25 21:25:44.178706 | LOOP [upload-logs : Upload console log and json output]