2026-08-01 06:02:59.999399 | Job console starting 2026-08-01 06:03:00.012071 | Updating git repos 2026-08-01 06:03:00.048557 | Cloning repos into workspace 2026-08-01 06:03:00.100194 | Restoring repo states 2026-08-01 06:03:00.112534 | Merging changes 2026-08-01 06:03:00.112569 | Checking out repos 2026-08-01 06:03:00.164991 | Preparing playbooks 2026-08-01 06:03:00.997674 | Running Ansible setup 2026-08-01 06:03:07.093709 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-01 06:03:08.105742 | 2026-08-01 06:03:08.106053 | PLAY [Base pre] 2026-08-01 06:03:08.125904 | 2026-08-01 06:03:08.126067 | TASK [Setup log path fact] 2026-08-01 06:03:08.161329 | noble | ok 2026-08-01 06:03:08.180661 | 2026-08-01 06:03:08.180893 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-01 06:03:08.212560 | noble | ok 2026-08-01 06:03:08.228675 | 2026-08-01 06:03:08.228851 | TASK [emit-job-header : Print job information] 2026-08-01 06:03:08.279080 | # Job Information 2026-08-01 06:03:08.279388 | Ansible Version: 2.16.14 2026-08-01 06:03:08.279448 | Job: openstack-ironic-images-publish-osism-ipa 2026-08-01 06:03:08.279501 | Pipeline: periodic-weekly 2026-08-01 06:03:08.279540 | Executor: 521e9411259a 2026-08-01 06:03:08.279574 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-08-01 06:03:08.279610 | Event ID: 439edea5335d49438e4782deb2947001 2026-08-01 06:03:08.287738 | 2026-08-01 06:03:08.287909 | LOOP [emit-job-header : Print node information] 2026-08-01 06:03:08.410818 | noble | ok: 2026-08-01 06:03:08.411132 | noble | # Node Information 2026-08-01 06:03:08.411167 | noble | Inventory Hostname: noble 2026-08-01 06:03:08.411193 | noble | Hostname: ubuntu 2026-08-01 06:03:08.411215 | noble | Username: zuul 2026-08-01 06:03:08.411236 | noble | Distro: Ubuntu 24.04 2026-08-01 06:03:08.411260 | noble | Provider: regiocloud-a 2026-08-01 06:03:08.411282 | noble | Region: 2026-08-01 06:03:08.411304 | noble | Label: ubuntu-noble-uefi 2026-08-01 06:03:08.411325 | noble | Product Name: OpenStack Nova 2026-08-01 06:03:08.411346 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:28e6 2026-08-01 06:03:08.425354 | 2026-08-01 06:03:08.425493 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-01 06:03:09.013282 | noble -> localhost | changed 2026-08-01 06:03:09.023986 | 2026-08-01 06:03:09.024122 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-01 06:03:10.107132 | noble -> localhost | changed 2026-08-01 06:03:10.125116 | 2026-08-01 06:03:10.125265 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-01 06:03:10.451256 | noble -> localhost | ok 2026-08-01 06:03:10.459459 | 2026-08-01 06:03:10.459600 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-01 06:03:10.502128 | noble | ok 2026-08-01 06:03:10.521369 | noble | included: /var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-01 06:03:10.528658 | 2026-08-01 06:03:10.528794 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-01 06:03:11.544454 | noble -> localhost | Generating public/private rsa key pair. 2026-08-01 06:03:11.544780 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/f6652f6857544ecdaa378ef8d6f8e9e5_id_rsa 2026-08-01 06:03:11.544823 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/f6652f6857544ecdaa378ef8d6f8e9e5_id_rsa.pub 2026-08-01 06:03:11.544850 | noble -> localhost | The key fingerprint is: 2026-08-01 06:03:11.544874 | noble -> localhost | SHA256:gX0GPAQtKDlDKi+/M76X3FzdglkFQfADiVgI59ODqoM zuul-build-sshkey 2026-08-01 06:03:11.544896 | noble -> localhost | The key's randomart image is: 2026-08-01 06:03:11.544919 | noble -> localhost | +---[RSA 3072]----+ 2026-08-01 06:03:11.544940 | noble -> localhost | | .oo.=o*=++o | 2026-08-01 06:03:11.544980 | noble -> localhost | | .=o+ooo=+ . | 2026-08-01 06:03:11.545002 | noble -> localhost | |o ++ +.o.=. | 2026-08-01 06:03:11.545022 | noble -> localhost | |.. . . . +.. | 2026-08-01 06:03:11.545042 | noble -> localhost | |. o S= . | 2026-08-01 06:03:11.545069 | noble -> localhost | |.+ + o . | 2026-08-01 06:03:11.545089 | noble -> localhost | |E .. + . . | 2026-08-01 06:03:11.545109 | noble -> localhost | | .o.+ o | 2026-08-01 06:03:11.545130 | noble -> localhost | | .+= | 2026-08-01 06:03:11.545150 | noble -> localhost | +----[SHA256]-----+ 2026-08-01 06:03:11.545210 | noble -> localhost | ok: Runtime: 0:00:00.499246 2026-08-01 06:03:11.553628 | 2026-08-01 06:03:11.553796 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-01 06:03:11.596448 | noble | ok 2026-08-01 06:03:11.607381 | noble | included: /var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-01 06:03:11.618673 | 2026-08-01 06:03:11.618880 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-01 06:03:11.659473 | noble | skipping: Conditional result was False 2026-08-01 06:03:11.669381 | 2026-08-01 06:03:11.669567 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-01 06:03:12.386284 | noble | changed 2026-08-01 06:03:12.395252 | 2026-08-01 06:03:12.395388 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-01 06:03:12.762741 | noble | ok 2026-08-01 06:03:12.773168 | 2026-08-01 06:03:12.773332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-01 06:03:13.611928 | noble | changed 2026-08-01 06:03:13.623066 | 2026-08-01 06:03:13.623254 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-01 06:03:14.452522 | noble | changed 2026-08-01 06:03:14.470052 | 2026-08-01 06:03:14.470297 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-01 06:03:14.507436 | noble | skipping: Conditional result was False 2026-08-01 06:03:14.525387 | 2026-08-01 06:03:14.525546 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-01 06:03:15.013586 | noble -> localhost | changed 2026-08-01 06:03:15.035351 | 2026-08-01 06:03:15.035516 | TASK [add-build-sshkey : Add back temp key] 2026-08-01 06:03:15.551286 | noble -> localhost | Identity added: /var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/f6652f6857544ecdaa378ef8d6f8e9e5_id_rsa (zuul-build-sshkey) 2026-08-01 06:03:15.551675 | noble -> localhost | ok: Runtime: 0:00:00.012020 2026-08-01 06:03:15.561922 | 2026-08-01 06:03:15.562061 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-01 06:03:16.035745 | noble | ok 2026-08-01 06:03:16.047728 | 2026-08-01 06:03:16.047951 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-01 06:03:16.072954 | noble | skipping: Conditional result was False 2026-08-01 06:03:16.143074 | 2026-08-01 06:03:16.143236 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-01 06:03:16.597875 | noble | ok 2026-08-01 06:03:16.615823 | 2026-08-01 06:03:16.615993 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-01 06:03:16.674082 | noble | ok 2026-08-01 06:03:16.689370 | 2026-08-01 06:03:16.689821 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-01 06:03:17.069452 | noble -> localhost | ok 2026-08-01 06:03:17.077862 | 2026-08-01 06:03:17.077996 | TASK [validate-host : Collect information about the host] 2026-08-01 06:03:18.630131 | noble | ok 2026-08-01 06:03:18.660512 | 2026-08-01 06:03:18.660682 | TASK [validate-host : Sanitize hostname] 2026-08-01 06:03:18.723049 | noble | ok 2026-08-01 06:03:18.729120 | 2026-08-01 06:03:18.729244 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-01 06:03:19.329590 | noble -> localhost | changed 2026-08-01 06:03:19.344727 | 2026-08-01 06:03:19.344929 | TASK [validate-host : Collect information about zuul worker] 2026-08-01 06:03:19.845243 | noble | ok 2026-08-01 06:03:19.851325 | 2026-08-01 06:03:19.851473 | TASK [validate-host : Write out all zuul information for each host] 2026-08-01 06:03:20.458668 | noble -> localhost | changed 2026-08-01 06:03:20.470675 | 2026-08-01 06:03:20.470922 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-01 06:03:20.782422 | noble | ok 2026-08-01 06:03:20.791283 | 2026-08-01 06:03:20.791422 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-01 06:03:21.791324 | noble | changed: 2026-08-01 06:03:21.791655 | noble | cd+++++++++ src/ 2026-08-01 06:03:21.791711 | noble | cd+++++++++ src/github.com/ 2026-08-01 06:03:21.791748 | noble | cd+++++++++ src/github.com/osism/ 2026-08-01 06:03:21.791795 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-08-01 06:03:21.791827 | noble | localhost | ok: "/var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/logs" 2026-08-01 06:10:15.992977 | noble -> localhost | changed: "/var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/artifacts" 2026-08-01 06:10:16.306859 | noble -> localhost | changed: "/var/lib/zuul/builds/f6652f6857544ecdaa378ef8d6f8e9e5/work/docs" 2026-08-01 06:10:16.331077 | 2026-08-01 06:10:16.331323 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-01 06:10:17.699812 | noble | changed: 2026-08-01 06:10:17.700092 | noble | .d..t...... ./ 2026-08-01 06:10:17.700131 | noble | >f+++++++++ net-debug.post.txt 2026-08-01 06:10:17.700156 | noble | >f+++++++++ net-debug.pre.txt 2026-08-01 06:10:17.700178 | noble | >f+++++++++ osism-ipa.log 2026-08-01 06:10:17.700200 | noble | >f+++++++++ sudo-debug.txt 2026-08-01 06:10:17.700221 | noble | >f+++++++++ sudo-strace.log 2026-08-01 06:10:17.700246 | noble | >f+++++++++ sudo-strace.log.time 2026-08-01 06:10:17.700285 | noble | changed: All items complete 2026-08-01 06:10:17.700307 | 2026-08-01 06:10:18.358112 | noble | changed: .d..t...... ./ 2026-08-01 06:10:19.011153 | noble | changed: .d..t...... ./ 2026-08-01 06:10:19.036634 | 2026-08-01 06:10:19.036805 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-01 06:10:19.067791 | noble | skipping: Conditional result was False 2026-08-01 06:10:19.072617 | noble | skipping: Conditional result was False 2026-08-01 06:10:19.098596 | 2026-08-01 06:10:19.098753 | PLAY RECAP 2026-08-01 06:10:19.098892 | noble | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-01 06:10:19.098933 | 2026-08-01 06:10:19.248071 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-01 06:10:19.250412 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-01 06:10:20.048532 | 2026-08-01 06:10:20.048728 | PLAY [Base post] 2026-08-01 06:10:20.064298 | 2026-08-01 06:10:20.064458 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-01 06:10:20.765127 | noble | changed 2026-08-01 06:10:20.775217 | 2026-08-01 06:10:20.775350 | PLAY RECAP 2026-08-01 06:10:20.775418 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-01 06:10:20.775490 | 2026-08-01 06:10:20.930876 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-01 06:10:20.931931 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-01 06:10:21.781656 | 2026-08-01 06:10:21.781837 | PLAY [Base post-logs] 2026-08-01 06:10:21.793345 | 2026-08-01 06:10:21.793484 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-01 06:10:22.351589 | localhost | changed 2026-08-01 06:10:22.369770 | 2026-08-01 06:10:22.370033 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-01 06:10:22.410073 | localhost | ok 2026-08-01 06:10:22.416423 | 2026-08-01 06:10:22.416584 | TASK [Set zuul-log-path fact] 2026-08-01 06:10:22.436319 | localhost | ok 2026-08-01 06:10:22.448956 | 2026-08-01 06:10:22.449148 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-01 06:10:22.486922 | localhost | ok 2026-08-01 06:10:22.492592 | 2026-08-01 06:10:22.492753 | TASK [upload-logs : Create log directories] 2026-08-01 06:10:23.064559 | localhost | changed 2026-08-01 06:10:23.067807 | 2026-08-01 06:10:23.067930 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-01 06:10:23.651206 | localhost -> localhost | ok: Runtime: 0:00:00.007729 2026-08-01 06:10:23.660952 | 2026-08-01 06:10:23.661181 | TASK [upload-logs : Upload logs to log server] 2026-08-01 06:10:24.291686 | localhost | Output suppressed because no_log was given 2026-08-01 06:10:24.296052 | 2026-08-01 06:10:24.296247 | LOOP [upload-logs : Compress console log and json output] 2026-08-01 06:10:24.349112 | localhost | skipping: Conditional result was False 2026-08-01 06:10:24.354484 | localhost | skipping: Conditional result was False 2026-08-01 06:10:24.368994 | 2026-08-01 06:10:24.369287 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-01 06:10:24.433048 | localhost | skipping: Conditional result was False 2026-08-01 06:10:24.433508 | 2026-08-01 06:10:24.441739 | localhost | skipping: Conditional result was False 2026-08-01 06:10:24.455414 | 2026-08-01 06:10:24.455670 | LOOP [upload-logs : Upload console log and json output]