2026-05-02 06:37:00.102471 | Job console starting 2026-05-02 06:37:00.116680 | Updating git repos 2026-05-02 06:37:00.139831 | Cloning repos into workspace 2026-05-02 06:37:00.177472 | Restoring repo states 2026-05-02 06:37:00.185806 | Merging changes 2026-05-02 06:37:00.185834 | Checking out repos 2026-05-02 06:37:00.236185 | Preparing playbooks 2026-05-02 06:37:00.916150 | Running Ansible setup 2026-05-02 06:37:06.839361 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-02 06:37:07.622881 | 2026-05-02 06:37:07.623065 | PLAY [Base pre] 2026-05-02 06:37:07.642449 | 2026-05-02 06:37:07.642621 | TASK [Setup log path fact] 2026-05-02 06:37:07.682672 | noble | ok 2026-05-02 06:37:07.704722 | 2026-05-02 06:37:07.704937 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 06:37:07.752201 | noble | ok 2026-05-02 06:37:07.768660 | 2026-05-02 06:37:07.768806 | TASK [emit-job-header : Print job information] 2026-05-02 06:37:07.822271 | # Job Information 2026-05-02 06:37:07.822501 | Ansible Version: 2.16.14 2026-05-02 06:37:07.822547 | Job: openstack-ironic-images-publish-osism-esp 2026-05-02 06:37:07.822591 | Pipeline: periodic-weekly 2026-05-02 06:37:07.822620 | Executor: 521e9411259a 2026-05-02 06:37:07.822646 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-05-02 06:37:07.822674 | Event ID: d1e647dd175c4d9ca7352ae11ee8f79d 2026-05-02 06:37:07.830452 | 2026-05-02 06:37:07.830585 | LOOP [emit-job-header : Print node information] 2026-05-02 06:37:07.955159 | noble | ok: 2026-05-02 06:37:07.955464 | noble | # Node Information 2026-05-02 06:37:07.955540 | noble | Inventory Hostname: noble 2026-05-02 06:37:07.955604 | noble | Hostname: ubuntu 2026-05-02 06:37:07.955663 | noble | Username: zuul 2026-05-02 06:37:07.955719 | noble | Distro: Ubuntu 24.04 2026-05-02 06:37:07.955788 | noble | Provider: regiocloud-a 2026-05-02 06:37:07.955844 | noble | Region: 2026-05-02 06:37:07.955965 | noble | Label: ubuntu-noble-uefi 2026-05-02 06:37:07.956024 | noble | Product Name: OpenStack Nova 2026-05-02 06:37:07.956080 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe43:9018 2026-05-02 06:37:07.983654 | 2026-05-02 06:37:07.983829 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-02 06:37:08.517782 | noble -> localhost | changed 2026-05-02 06:37:08.534683 | 2026-05-02 06:37:08.534996 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-02 06:37:09.614083 | noble -> localhost | changed 2026-05-02 06:37:09.637485 | 2026-05-02 06:37:09.637636 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-02 06:37:09.966790 | noble -> localhost | ok 2026-05-02 06:37:09.974379 | 2026-05-02 06:37:09.974518 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-02 06:37:10.012297 | noble | ok 2026-05-02 06:37:10.040819 | noble | included: /var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-02 06:37:10.048642 | 2026-05-02 06:37:10.048780 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-02 06:37:11.122331 | noble -> localhost | Generating public/private rsa key pair. 2026-05-02 06:37:11.122783 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/020aafa48d6f4a23bf1b593bdf07444b_id_rsa 2026-05-02 06:37:11.122917 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/020aafa48d6f4a23bf1b593bdf07444b_id_rsa.pub 2026-05-02 06:37:11.122966 | noble -> localhost | The key fingerprint is: 2026-05-02 06:37:11.123007 | noble -> localhost | SHA256:f1EsjmIkhe4iHvKNAtzewTh0P6c46Hm9JRMOkR5+334 zuul-build-sshkey 2026-05-02 06:37:11.123046 | noble -> localhost | The key's randomart image is: 2026-05-02 06:37:11.123082 | noble -> localhost | +---[RSA 3072]----+ 2026-05-02 06:37:11.123118 | noble -> localhost | | .. | 2026-05-02 06:37:11.123177 | noble -> localhost | | o. . | 2026-05-02 06:37:11.123214 | noble -> localhost | | =. . . o | 2026-05-02 06:37:11.123248 | noble -> localhost | | .o.+o o o | 2026-05-02 06:37:11.123283 | noble -> localhost | |. o +=.oS . o | 2026-05-02 06:37:11.123348 | noble -> localhost | |o.o+.o=+o+. . | 2026-05-02 06:37:11.123387 | noble -> localhost | |.+.=+.+++o... | 2026-05-02 06:37:11.123423 | noble -> localhost | |. +oo= o+ .. E | 2026-05-02 06:37:11.123459 | noble -> localhost | | ..o. ... .. | 2026-05-02 06:37:11.123495 | noble -> localhost | +----[SHA256]-----+ 2026-05-02 06:37:11.123616 | noble -> localhost | ok: Runtime: 0:00:00.544322 2026-05-02 06:37:11.140939 | 2026-05-02 06:37:11.141182 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-02 06:37:11.176585 | noble | ok 2026-05-02 06:37:11.189702 | noble | included: /var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-02 06:37:11.200815 | 2026-05-02 06:37:11.200980 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-02 06:37:11.225122 | noble | skipping: Conditional result was False 2026-05-02 06:37:11.232517 | 2026-05-02 06:37:11.232645 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-02 06:37:11.873915 | noble | changed 2026-05-02 06:37:11.880775 | 2026-05-02 06:37:11.880939 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-02 06:37:12.191574 | noble | ok 2026-05-02 06:37:12.203081 | 2026-05-02 06:37:12.203228 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-02 06:37:13.014336 | noble | changed 2026-05-02 06:37:13.023814 | 2026-05-02 06:37:13.023992 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-02 06:37:13.851471 | noble | changed 2026-05-02 06:37:13.859002 | 2026-05-02 06:37:13.859123 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-02 06:37:13.884702 | noble | skipping: Conditional result was False 2026-05-02 06:37:13.898970 | 2026-05-02 06:37:13.899137 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-02 06:37:14.369971 | noble -> localhost | changed 2026-05-02 06:37:14.385196 | 2026-05-02 06:37:14.385351 | TASK [add-build-sshkey : Add back temp key] 2026-05-02 06:37:14.734714 | noble -> localhost | Identity added: /var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/020aafa48d6f4a23bf1b593bdf07444b_id_rsa (zuul-build-sshkey) 2026-05-02 06:37:14.735308 | noble -> localhost | ok: Runtime: 0:00:00.017301 2026-05-02 06:37:14.751099 | 2026-05-02 06:37:14.751289 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-02 06:37:15.228382 | noble | ok 2026-05-02 06:37:15.239436 | 2026-05-02 06:37:15.239632 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-02 06:37:15.275944 | noble | skipping: Conditional result was False 2026-05-02 06:37:15.346505 | 2026-05-02 06:37:15.346668 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-02 06:37:15.781754 | noble | ok 2026-05-02 06:37:15.795902 | 2026-05-02 06:37:15.796033 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-02 06:37:15.845407 | noble | ok 2026-05-02 06:37:15.853717 | 2026-05-02 06:37:15.853850 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-02 06:37:16.183391 | noble -> localhost | ok 2026-05-02 06:37:16.195725 | 2026-05-02 06:37:16.195926 | TASK [validate-host : Collect information about the host] 2026-05-02 06:37:17.635999 | noble | ok 2026-05-02 06:37:17.655645 | 2026-05-02 06:37:17.655803 | TASK [validate-host : Sanitize hostname] 2026-05-02 06:37:17.730224 | noble | ok 2026-05-02 06:37:17.738562 | 2026-05-02 06:37:17.738704 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-02 06:37:18.321593 | noble -> localhost | changed 2026-05-02 06:37:18.335957 | 2026-05-02 06:37:18.336165 | TASK [validate-host : Collect information about zuul worker] 2026-05-02 06:37:18.821413 | noble | ok 2026-05-02 06:37:18.830949 | 2026-05-02 06:37:18.831120 | TASK [validate-host : Write out all zuul information for each host] 2026-05-02 06:37:19.392390 | noble -> localhost | changed 2026-05-02 06:37:19.404214 | 2026-05-02 06:37:19.404349 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-02 06:37:19.744033 | noble | ok 2026-05-02 06:37:19.753797 | 2026-05-02 06:37:19.753953 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-02 06:37:20.696026 | noble | changed: 2026-05-02 06:37:20.696342 | noble | cd+++++++++ src/ 2026-05-02 06:37:20.696401 | noble | cd+++++++++ src/github.com/ 2026-05-02 06:37:20.696444 | noble | cd+++++++++ src/github.com/osism/ 2026-05-02 06:37:20.696482 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-05-02 06:37:20.696519 | noble | localhost | ok: "/var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/logs" 2026-05-02 06:40:55.661202 | noble -> localhost | changed: "/var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/artifacts" 2026-05-02 06:40:55.943563 | noble -> localhost | changed: "/var/lib/zuul/builds/020aafa48d6f4a23bf1b593bdf07444b/work/docs" 2026-05-02 06:40:55.977705 | 2026-05-02 06:40:55.977949 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-02 06:40:57.320431 | noble | changed: 2026-05-02 06:40:57.320745 | noble | .d..t...... ./ 2026-05-02 06:40:57.320821 | noble | >f+++++++++ osism-esp.log 2026-05-02 06:40:57.320873 | noble | >f+++++++++ sudo-debug.txt 2026-05-02 06:40:57.320917 | noble | >f+++++++++ sudo-strace.log 2026-05-02 06:40:57.320952 | noble | >f+++++++++ sudo-strace.log.time 2026-05-02 06:40:57.321011 | noble | changed: All items complete 2026-05-02 06:40:57.321045 | 2026-05-02 06:40:57.974941 | noble | changed: .d..t...... ./ 2026-05-02 06:40:58.628998 | noble | changed: .d..t...... ./ 2026-05-02 06:40:58.655450 | 2026-05-02 06:40:58.655605 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-02 06:40:58.693513 | noble | skipping: Conditional result was False 2026-05-02 06:40:58.697763 | noble | skipping: Conditional result was False 2026-05-02 06:40:58.710619 | 2026-05-02 06:40:58.710718 | PLAY RECAP 2026-05-02 06:40:58.710805 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-02 06:40:58.710860 | 2026-05-02 06:40:58.853666 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-02 06:40:58.854653 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 06:40:59.592417 | 2026-05-02 06:40:59.592591 | PLAY [Base post] 2026-05-02 06:40:59.607868 | 2026-05-02 06:40:59.608029 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-02 06:41:00.289085 | noble | changed 2026-05-02 06:41:00.300977 | 2026-05-02 06:41:00.301122 | PLAY RECAP 2026-05-02 06:41:00.301214 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-02 06:41:00.301290 | 2026-05-02 06:41:00.446556 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 06:41:00.447586 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-02 06:41:01.266911 | 2026-05-02 06:41:01.267126 | PLAY [Base post-logs] 2026-05-02 06:41:01.280707 | 2026-05-02 06:41:01.280937 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-02 06:41:01.756815 | localhost | changed 2026-05-02 06:41:01.767502 | 2026-05-02 06:41:01.767679 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-02 06:41:01.803592 | localhost | ok 2026-05-02 06:41:01.807190 | 2026-05-02 06:41:01.807304 | TASK [Set zuul-log-path fact] 2026-05-02 06:41:01.822916 | localhost | ok 2026-05-02 06:41:01.834000 | 2026-05-02 06:41:01.834169 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 06:41:01.877381 | localhost | ok 2026-05-02 06:41:01.887004 | 2026-05-02 06:41:01.887239 | TASK [upload-logs : Create log directories] 2026-05-02 06:41:02.410050 | localhost | changed 2026-05-02 06:41:02.416275 | 2026-05-02 06:41:02.416458 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-02 06:41:02.940460 | localhost -> localhost | ok: Runtime: 0:00:00.007071 2026-05-02 06:41:02.944888 | 2026-05-02 06:41:02.945012 | TASK [upload-logs : Upload logs to log server] 2026-05-02 06:41:03.522142 | localhost | Output suppressed because no_log was given 2026-05-02 06:41:03.524197 | 2026-05-02 06:41:03.524309 | LOOP [upload-logs : Compress console log and json output] 2026-05-02 06:41:03.582567 | localhost | skipping: Conditional result was False 2026-05-02 06:41:03.597140 | localhost | skipping: Conditional result was False 2026-05-02 06:41:03.603908 | 2026-05-02 06:41:03.604116 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-02 06:41:03.663592 | localhost | skipping: Conditional result was False 2026-05-02 06:41:03.664233 | 2026-05-02 06:41:03.667829 | localhost | skipping: Conditional result was False 2026-05-02 06:41:03.675905 | 2026-05-02 06:41:03.676128 | LOOP [upload-logs : Upload console log and json output]