2026-10-02 12:20:58.568345 | Job console starting 2026-10-02 12:20:58.580817 | Updating git repos 2026-10-02 12:20:58.606711 | Cloning repos into workspace 2026-10-02 12:20:58.675033 | Restoring repo states 2026-10-02 12:20:58.679823 | Merging changes 2026-10-02 12:20:59.205322 | Checking out repos 2026-10-02 12:20:59.242238 | Preparing playbooks 2026-10-02 12:20:59.990929 | Running Ansible setup 2026-10-02 12:21:06.383081 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-02 12:21:07.194069 | 2026-10-02 12:21:07.194245 | PLAY [Base pre] 2026-10-02 12:21:07.214659 | 2026-10-02 12:21:07.214803 | TASK [Setup log path fact] 2026-10-02 12:21:07.245890 | noble | ok 2026-10-02 12:21:07.265014 | 2026-10-02 12:21:07.265153 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 12:21:07.300691 | noble | ok 2026-10-02 12:21:07.315003 | 2026-10-02 12:21:07.315162 | TASK [emit-job-header : Print job information] 2026-10-02 12:21:07.358231 | # Job Information 2026-10-02 12:21:07.358403 | Ansible Version: 2.16.14 2026-10-02 12:21:07.358439 | Job: openstack-ironic-images-build-osism-ipa-latest 2026-10-02 12:21:07.358494 | Pipeline: check 2026-10-02 12:21:07.358519 | Executor: 521e9411259a 2026-10-02 12:21:07.358540 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/220 2026-10-02 12:21:07.358563 | Event ID: 06cd2dc0-be5a-11f1-992f-18c497538d87 2026-10-02 12:21:07.364268 | 2026-10-02 12:21:07.364376 | LOOP [emit-job-header : Print node information] 2026-10-02 12:21:07.481821 | noble | ok: 2026-10-02 12:21:07.482024 | noble | # Node Information 2026-10-02 12:21:07.482060 | noble | Inventory Hostname: noble 2026-10-02 12:21:07.482085 | noble | Hostname: ubuntu 2026-10-02 12:21:07.482107 | noble | Username: zuul 2026-10-02 12:21:07.482127 | noble | Distro: Ubuntu 24.04 2026-10-02 12:21:07.482150 | noble | Provider: regiocloud-a 2026-10-02 12:21:07.482171 | noble | Region: 2026-10-02 12:21:07.482192 | noble | Label: ubuntu-noble-uefi 2026-10-02 12:21:07.482211 | noble | Product Name: OpenStack Nova 2026-10-02 12:21:07.482230 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea9:a9c0 2026-10-02 12:21:07.494915 | 2026-10-02 12:21:07.495051 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-02 12:21:07.963288 | noble -> localhost | changed 2026-10-02 12:21:07.972876 | 2026-10-02 12:21:07.973006 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-02 12:21:09.074039 | noble -> localhost | changed 2026-10-02 12:21:09.087979 | 2026-10-02 12:21:09.088106 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-02 12:21:09.365160 | noble -> localhost | ok 2026-10-02 12:21:09.373110 | 2026-10-02 12:21:09.373239 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-02 12:21:09.406478 | noble | ok 2026-10-02 12:21:09.425839 | noble | included: /var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-02 12:21:09.432897 | 2026-10-02 12:21:09.433001 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-02 12:21:11.472237 | noble -> localhost | Generating public/private rsa key pair. 2026-10-02 12:21:11.472481 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/98139a15638c49a58e281192a5fa7d08_id_rsa 2026-10-02 12:21:11.472522 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/98139a15638c49a58e281192a5fa7d08_id_rsa.pub 2026-10-02 12:21:11.472550 | noble -> localhost | The key fingerprint is: 2026-10-02 12:21:11.472573 | noble -> localhost | SHA256:2OGfwB6PZ4msjrs1YcnxMBg+CgMku38B6ps99ADlHuw zuul-build-sshkey 2026-10-02 12:21:11.472597 | noble -> localhost | The key's randomart image is: 2026-10-02 12:21:11.472618 | noble -> localhost | +---[RSA 3072]----+ 2026-10-02 12:21:11.472639 | noble -> localhost | |+. . | 2026-10-02 12:21:11.472676 | noble -> localhost | |o. o o | 2026-10-02 12:21:11.472698 | noble -> localhost | |+ = + + . | 2026-10-02 12:21:11.472719 | noble -> localhost | | * * o @ . | 2026-10-02 12:21:11.472739 | noble -> localhost | |o = o * S | 2026-10-02 12:21:11.472769 | noble -> localhost | |.. E o + B o | 2026-10-02 12:21:11.472790 | noble -> localhost | | .o + o = B | 2026-10-02 12:21:11.472810 | noble -> localhost | | +o + o o | 2026-10-02 12:21:11.472830 | noble -> localhost | | o .=+o | 2026-10-02 12:21:11.472851 | noble -> localhost | +----[SHA256]-----+ 2026-10-02 12:21:11.472903 | noble -> localhost | ok: Runtime: 0:00:01.557283 2026-10-02 12:21:11.484826 | 2026-10-02 12:21:11.484961 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-02 12:21:11.515213 | noble | ok 2026-10-02 12:21:11.525776 | noble | included: /var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-02 12:21:11.536797 | 2026-10-02 12:21:11.536904 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-02 12:21:11.552349 | noble | skipping: Conditional result was False 2026-10-02 12:21:11.559233 | 2026-10-02 12:21:11.559343 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-02 12:21:12.378637 | noble | changed 2026-10-02 12:21:12.385312 | 2026-10-02 12:21:12.385461 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-02 12:21:12.813265 | noble | ok 2026-10-02 12:21:12.822011 | 2026-10-02 12:21:12.822123 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-02 12:21:13.713022 | noble | changed 2026-10-02 12:21:13.727551 | 2026-10-02 12:21:13.727689 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-02 12:21:14.583824 | noble | changed 2026-10-02 12:21:14.592290 | 2026-10-02 12:21:14.592431 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-02 12:21:14.616648 | noble | skipping: Conditional result was False 2026-10-02 12:21:14.624871 | 2026-10-02 12:21:14.624983 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-02 12:21:15.066019 | noble -> localhost | changed 2026-10-02 12:21:15.080208 | 2026-10-02 12:21:15.080415 | TASK [add-build-sshkey : Add back temp key] 2026-10-02 12:21:15.430543 | noble -> localhost | Identity added: /var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/98139a15638c49a58e281192a5fa7d08_id_rsa (zuul-build-sshkey) 2026-10-02 12:21:15.430790 | noble -> localhost | ok: Runtime: 0:00:00.018886 2026-10-02 12:21:15.438261 | 2026-10-02 12:21:15.438413 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-02 12:21:16.003872 | noble | ok 2026-10-02 12:21:16.015180 | 2026-10-02 12:21:16.015300 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-02 12:21:16.049359 | noble | skipping: Conditional result was False 2026-10-02 12:21:16.106044 | 2026-10-02 12:21:16.106166 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-02 12:21:16.588959 | noble | ok 2026-10-02 12:21:16.601967 | 2026-10-02 12:21:16.602084 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-02 12:21:16.653429 | noble | ok 2026-10-02 12:21:16.659691 | 2026-10-02 12:21:16.659806 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-02 12:21:16.958019 | noble -> localhost | ok 2026-10-02 12:21:16.966375 | 2026-10-02 12:21:16.966480 | TASK [validate-host : Collect information about the host] 2026-10-02 12:21:18.471203 | noble | ok 2026-10-02 12:21:18.488185 | 2026-10-02 12:21:18.488338 | TASK [validate-host : Sanitize hostname] 2026-10-02 12:21:18.560447 | noble | ok 2026-10-02 12:21:18.569717 | 2026-10-02 12:21:18.569871 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-02 12:21:19.123224 | noble -> localhost | changed 2026-10-02 12:21:19.133469 | 2026-10-02 12:21:19.133621 | TASK [validate-host : Collect information about zuul worker] 2026-10-02 12:21:19.717827 | noble | ok 2026-10-02 12:21:19.724271 | 2026-10-02 12:21:19.724401 | TASK [validate-host : Write out all zuul information for each host] 2026-10-02 12:21:20.272287 | noble -> localhost | changed 2026-10-02 12:21:20.290791 | 2026-10-02 12:21:20.290933 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-02 12:21:20.709697 | noble | ok 2026-10-02 12:21:20.715545 | 2026-10-02 12:21:20.715629 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-02 12:21:21.627762 | noble | changed: 2026-10-02 12:21:21.627934 | noble | cd+++++++++ src/ 2026-10-02 12:21:21.627972 | noble | cd+++++++++ src/github.com/ 2026-10-02 12:21:21.627998 | noble | cd+++++++++ src/github.com/osism/ 2026-10-02 12:21:21.628021 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-10-02 12:21:21.628042 | noble | localhost | ok: "/var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/logs" 2026-10-02 12:28:19.255047 | noble -> localhost | changed: "/var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/artifacts" 2026-10-02 12:28:19.542791 | noble -> localhost | changed: "/var/lib/zuul/builds/98139a15638c49a58e281192a5fa7d08/work/docs" 2026-10-02 12:28:19.566227 | 2026-10-02 12:28:19.566369 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-02 12:28:20.966993 | noble | changed: 2026-10-02 12:28:20.967225 | noble | .d..t...... ./ 2026-10-02 12:28:20.967262 | noble | >f+++++++++ net-debug.post.txt 2026-10-02 12:28:20.967287 | noble | >f+++++++++ net-debug.pre.txt 2026-10-02 12:28:20.967308 | noble | >f+++++++++ osism-ipa-latest.log 2026-10-02 12:28:20.967329 | noble | >f+++++++++ sudo-debug.txt 2026-10-02 12:28:20.967349 | noble | >f+++++++++ sudo-strace.log 2026-10-02 12:28:20.967368 | noble | >f+++++++++ sudo-strace.log.time 2026-10-02 12:28:20.967443 | noble | changed: All items complete 2026-10-02 12:28:20.967468 | 2026-10-02 12:28:21.590760 | noble | changed: .d..t...... ./ 2026-10-02 12:28:22.255954 | noble | changed: .d..t...... ./ 2026-10-02 12:28:22.276906 | 2026-10-02 12:28:22.277035 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-02 12:28:22.597366 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007597 2026-10-02 12:28:22.885618 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.008357 2026-10-02 12:28:22.911577 | 2026-10-02 12:28:22.911700 | PLAY RECAP 2026-10-02 12:28:22.911773 | noble | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-02 12:28:22.911811 | 2026-10-02 12:28:23.077636 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-02 12:28:23.079052 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 12:28:23.862723 | 2026-10-02 12:28:23.862887 | PLAY [Base post] 2026-10-02 12:28:23.877456 | 2026-10-02 12:28:23.877621 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-02 12:28:24.533802 | noble | changed 2026-10-02 12:28:24.544312 | 2026-10-02 12:28:24.544451 | PLAY RECAP 2026-10-02 12:28:24.544519 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-02 12:28:24.544584 | 2026-10-02 12:28:24.674061 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 12:28:24.676293 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-02 12:28:25.519640 | 2026-10-02 12:28:25.519807 | PLAY [Base post-logs] 2026-10-02 12:28:25.530530 | 2026-10-02 12:28:25.530661 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-02 12:28:25.984464 | localhost | changed 2026-10-02 12:28:25.994733 | 2026-10-02 12:28:25.994897 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-02 12:28:26.020155 | localhost | ok 2026-10-02 12:28:26.023349 | 2026-10-02 12:28:26.023493 | TASK [Set zuul-log-path fact] 2026-10-02 12:28:26.038071 | localhost | ok 2026-10-02 12:28:26.046075 | 2026-10-02 12:28:26.046186 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 12:28:26.070617 | localhost | ok 2026-10-02 12:28:26.073816 | 2026-10-02 12:28:26.073918 | TASK [upload-logs : Create log directories] 2026-10-02 12:28:26.588229 | localhost | changed 2026-10-02 12:28:26.591173 | 2026-10-02 12:28:26.591279 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-02 12:28:27.102120 | localhost -> localhost | ok: Runtime: 0:00:00.007936 2026-10-02 12:28:27.111795 | 2026-10-02 12:28:27.112012 | TASK [upload-logs : Upload logs to log server] 2026-10-02 12:28:27.709412 | localhost | Output suppressed because no_log was given 2026-10-02 12:28:27.711301 | 2026-10-02 12:28:27.711421 | LOOP [upload-logs : Compress console log and json output] 2026-10-02 12:28:27.759073 | localhost | skipping: Conditional result was False 2026-10-02 12:28:27.764236 | localhost | skipping: Conditional result was False 2026-10-02 12:28:27.768250 | 2026-10-02 12:28:27.768362 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-02 12:28:27.822385 | localhost | skipping: Conditional result was False 2026-10-02 12:28:27.822670 | 2026-10-02 12:28:27.829478 | localhost | skipping: Conditional result was False 2026-10-02 12:28:27.839719 | 2026-10-02 12:28:27.839904 | LOOP [upload-logs : Upload console log and json output]