2026-01-10 06:02:58.850163 | Job console starting 2026-01-10 06:02:58.858152 | Updating git repos 2026-01-10 06:02:58.877348 | Cloning repos into workspace 2026-01-10 06:02:58.928784 | Restoring repo states 2026-01-10 06:02:58.933989 | Merging changes 2026-01-10 06:02:58.934007 | Checking out repos 2026-01-10 06:02:59.015243 | Preparing playbooks 2026-01-10 06:02:59.693136 | Running Ansible setup 2026-01-10 06:03:05.548822 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-10 06:03:06.373143 | 2026-01-10 06:03:06.373329 | PLAY [Base pre] 2026-01-10 06:03:06.392462 | 2026-01-10 06:03:06.392632 | TASK [Setup log path fact] 2026-01-10 06:03:06.429858 | noble | ok 2026-01-10 06:03:06.461460 | 2026-01-10 06:03:06.461753 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-10 06:03:06.510040 | noble | ok 2026-01-10 06:03:06.525920 | 2026-01-10 06:03:06.526113 | TASK [emit-job-header : Print job information] 2026-01-10 06:03:06.566607 | # Job Information 2026-01-10 06:03:06.566815 | Ansible Version: 2.16.14 2026-01-10 06:03:06.566889 | Job: openstack-ironic-images-publish-osism-ipa 2026-01-10 06:03:06.566924 | Pipeline: periodic-weekly 2026-01-10 06:03:06.566947 | Executor: 521e9411259a 2026-01-10 06:03:06.566968 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-01-10 06:03:06.566991 | Event ID: eb9ac39dff2f4ba68224a249889c8801 2026-01-10 06:03:06.574171 | 2026-01-10 06:03:06.574311 | LOOP [emit-job-header : Print node information] 2026-01-10 06:03:06.696928 | noble | ok: 2026-01-10 06:03:06.697179 | noble | # Node Information 2026-01-10 06:03:06.697215 | noble | Inventory Hostname: noble 2026-01-10 06:03:06.697240 | noble | Hostname: ubuntu 2026-01-10 06:03:06.697262 | noble | Username: zuul 2026-01-10 06:03:06.697283 | noble | Distro: Ubuntu 24.04 2026-01-10 06:03:06.697306 | noble | Provider: regiocloud-a 2026-01-10 06:03:06.697327 | noble | Region: 2026-01-10 06:03:06.697349 | noble | Label: ubuntu-noble-uefi 2026-01-10 06:03:06.697368 | noble | Product Name: OpenStack Nova 2026-01-10 06:03:06.697389 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef3:73af 2026-01-10 06:03:06.721701 | 2026-01-10 06:03:06.721857 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-10 06:03:07.358386 | noble -> localhost | changed 2026-01-10 06:03:07.374057 | 2026-01-10 06:03:07.374260 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-10 06:03:08.599128 | noble -> localhost | changed 2026-01-10 06:03:08.613569 | 2026-01-10 06:03:08.613737 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-10 06:03:08.933383 | noble -> localhost | ok 2026-01-10 06:03:08.940646 | 2026-01-10 06:03:08.940794 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-10 06:03:08.988993 | noble | ok 2026-01-10 06:03:09.017024 | noble | included: /var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-10 06:03:09.028951 | 2026-01-10 06:03:09.029123 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-10 06:03:09.894278 | noble -> localhost | Generating public/private rsa key pair. 2026-01-10 06:03:09.894640 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/57574e36633049f8a2514d653ff280be_id_rsa 2026-01-10 06:03:09.894727 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/57574e36633049f8a2514d653ff280be_id_rsa.pub 2026-01-10 06:03:09.894775 | noble -> localhost | The key fingerprint is: 2026-01-10 06:03:09.894817 | noble -> localhost | SHA256:QbxpX4y3nqaak50XZ79sDkDH0AgkPUA1uasxKkHBkRc zuul-build-sshkey 2026-01-10 06:03:09.894882 | noble -> localhost | The key's randomart image is: 2026-01-10 06:03:09.894920 | noble -> localhost | +---[RSA 3072]----+ 2026-01-10 06:03:09.894956 | noble -> localhost | | ..oEo=*=o.o | 2026-01-10 06:03:09.895011 | noble -> localhost | | + . .o+..o. | 2026-01-10 06:03:09.895049 | noble -> localhost | | o .oo+ o | 2026-01-10 06:03:09.895082 | noble -> localhost | | . +oo = | 2026-01-10 06:03:09.895115 | noble -> localhost | | . .S..+ . | 2026-01-10 06:03:09.895164 | noble -> localhost | | . o .. + o | 2026-01-10 06:03:09.895200 | noble -> localhost | | . . +o o * . | 2026-01-10 06:03:09.895234 | noble -> localhost | | . . .o.o = o..| 2026-01-10 06:03:09.895270 | noble -> localhost | | . oo.+ o+.| 2026-01-10 06:03:09.895304 | noble -> localhost | +----[SHA256]-----+ 2026-01-10 06:03:09.895392 | noble -> localhost | ok: Runtime: 0:00:00.335099 2026-01-10 06:03:09.907757 | 2026-01-10 06:03:09.907912 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-10 06:03:09.943178 | noble | ok 2026-01-10 06:03:09.957600 | noble | included: /var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-10 06:03:09.967319 | 2026-01-10 06:03:09.967447 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-10 06:03:09.992275 | noble | skipping: Conditional result was False 2026-01-10 06:03:10.001534 | 2026-01-10 06:03:10.001690 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-10 06:03:10.666714 | noble | changed 2026-01-10 06:03:10.676013 | 2026-01-10 06:03:10.676161 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-10 06:03:10.991549 | noble | ok 2026-01-10 06:03:11.003407 | 2026-01-10 06:03:11.003567 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-10 06:03:11.802176 | noble | changed 2026-01-10 06:03:11.811173 | 2026-01-10 06:03:11.811317 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-10 06:03:12.607731 | noble | changed 2026-01-10 06:03:12.629170 | 2026-01-10 06:03:12.629319 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-10 06:03:12.654468 | noble | skipping: Conditional result was False 2026-01-10 06:03:12.662050 | 2026-01-10 06:03:12.662187 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-10 06:03:13.099390 | noble -> localhost | changed 2026-01-10 06:03:13.114417 | 2026-01-10 06:03:13.114553 | TASK [add-build-sshkey : Add back temp key] 2026-01-10 06:03:13.492632 | noble -> localhost | Identity added: /var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/57574e36633049f8a2514d653ff280be_id_rsa (zuul-build-sshkey) 2026-01-10 06:03:13.492908 | noble -> localhost | ok: Runtime: 0:00:00.013634 2026-01-10 06:03:13.500422 | 2026-01-10 06:03:13.500554 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-10 06:03:13.963939 | noble | ok 2026-01-10 06:03:13.970422 | 2026-01-10 06:03:13.970558 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-10 06:03:13.994466 | noble | skipping: Conditional result was False 2026-01-10 06:03:14.056643 | 2026-01-10 06:03:14.056803 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-10 06:03:14.534496 | noble | ok 2026-01-10 06:03:14.560075 | 2026-01-10 06:03:14.560314 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-10 06:03:14.594377 | noble | ok 2026-01-10 06:03:14.605267 | 2026-01-10 06:03:14.605404 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-10 06:03:14.904495 | noble -> localhost | ok 2026-01-10 06:03:14.912478 | 2026-01-10 06:03:14.912600 | TASK [validate-host : Collect information about the host] 2026-01-10 06:03:16.403072 | noble | ok 2026-01-10 06:03:16.421902 | 2026-01-10 06:03:16.422089 | TASK [validate-host : Sanitize hostname] 2026-01-10 06:03:16.481806 | noble | ok 2026-01-10 06:03:16.487639 | 2026-01-10 06:03:16.487796 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-10 06:03:17.075064 | noble -> localhost | changed 2026-01-10 06:03:17.088484 | 2026-01-10 06:03:17.088765 | TASK [validate-host : Collect information about zuul worker] 2026-01-10 06:03:17.610518 | noble | ok 2026-01-10 06:03:17.619615 | 2026-01-10 06:03:17.619868 | TASK [validate-host : Write out all zuul information for each host] 2026-01-10 06:03:18.257542 | noble -> localhost | changed 2026-01-10 06:03:18.278945 | 2026-01-10 06:03:18.279252 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-10 06:03:18.597240 | noble | ok 2026-01-10 06:03:18.603898 | 2026-01-10 06:03:18.604016 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-10 06:03:19.594823 | noble | changed: 2026-01-10 06:03:19.595075 | noble | cd+++++++++ src/ 2026-01-10 06:03:19.595114 | noble | cd+++++++++ src/github.com/ 2026-01-10 06:03:19.595140 | noble | cd+++++++++ src/github.com/osism/ 2026-01-10 06:03:19.595163 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-01-10 06:03:19.595185 | noble | localhost | ok: "/var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/logs" 2026-01-10 06:10:16.697889 | noble -> localhost | changed: "/var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/artifacts" 2026-01-10 06:10:16.999241 | noble -> localhost | changed: "/var/lib/zuul/builds/57574e36633049f8a2514d653ff280be/work/docs" 2026-01-10 06:10:17.016059 | 2026-01-10 06:10:17.016205 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-10 06:10:18.387266 | noble | changed: 2026-01-10 06:10:18.387649 | noble | .d..t...... ./ 2026-01-10 06:10:18.387709 | noble | >f+++++++++ osism-ipa.log 2026-01-10 06:10:18.387792 | noble | changed: All items complete 2026-01-10 06:10:18.387871 | 2026-01-10 06:10:19.080836 | noble | changed: .d..t...... ./ 2026-01-10 06:10:19.769163 | noble | changed: .d..t...... ./ 2026-01-10 06:10:19.804899 | 2026-01-10 06:10:19.805064 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-10 06:10:19.837499 | noble | skipping: Conditional result was False 2026-01-10 06:10:19.841557 | noble | skipping: Conditional result was False 2026-01-10 06:10:19.861202 | 2026-01-10 06:10:19.861316 | PLAY RECAP 2026-01-10 06:10:19.861393 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-01-10 06:10:19.861422 | 2026-01-10 06:10:20.011554 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-01-10 06:10:20.012597 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-10 06:10:20.793415 | 2026-01-10 06:10:20.793600 | PLAY [Base post] 2026-01-10 06:10:20.809996 | 2026-01-10 06:10:20.810173 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-10 06:10:21.496447 | noble | changed 2026-01-10 06:10:21.507723 | 2026-01-10 06:10:21.507904 | PLAY RECAP 2026-01-10 06:10:21.507988 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-10 06:10:21.508065 | 2026-01-10 06:10:21.646215 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-10 06:10:21.648846 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-10 06:10:22.465932 | 2026-01-10 06:10:22.466114 | PLAY [Base post-logs] 2026-01-10 06:10:22.477440 | 2026-01-10 06:10:22.477597 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-10 06:10:22.981759 | localhost | changed 2026-01-10 06:10:22.991985 | 2026-01-10 06:10:22.992139 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-10 06:10:23.028642 | localhost | ok 2026-01-10 06:10:23.032404 | 2026-01-10 06:10:23.032531 | TASK [Set zuul-log-path fact] 2026-01-10 06:10:23.051274 | localhost | ok 2026-01-10 06:10:23.067930 | 2026-01-10 06:10:23.068094 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-10 06:10:23.106240 | localhost | ok 2026-01-10 06:10:23.111510 | 2026-01-10 06:10:23.111695 | TASK [upload-logs : Create log directories] 2026-01-10 06:10:23.629727 | localhost | changed 2026-01-10 06:10:23.633027 | 2026-01-10 06:10:23.633156 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-10 06:10:24.165775 | localhost -> localhost | ok: Runtime: 0:00:00.006492 2026-01-10 06:10:24.170422 | 2026-01-10 06:10:24.170559 | TASK [upload-logs : Upload logs to log server] 2026-01-10 06:10:24.809095 | localhost | Output suppressed because no_log was given 2026-01-10 06:10:24.813133 | 2026-01-10 06:10:24.813305 | LOOP [upload-logs : Compress console log and json output] 2026-01-10 06:10:24.893068 | localhost | skipping: Conditional result was False 2026-01-10 06:10:24.899056 | localhost | skipping: Conditional result was False 2026-01-10 06:10:24.906484 | 2026-01-10 06:10:24.906682 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-10 06:10:24.956442 | localhost | skipping: Conditional result was False 2026-01-10 06:10:24.957138 | 2026-01-10 06:10:24.960190 | localhost | skipping: Conditional result was False 2026-01-10 06:10:24.969500 | 2026-01-10 06:10:24.969728 | LOOP [upload-logs : Upload console log and json output]