2026-03-08 22:44:44.339841 | Job console starting 2026-03-08 22:44:44.354050 | Updating git repos 2026-03-08 22:44:44.373145 | Cloning repos into workspace 2026-03-08 22:44:44.429792 | Restoring repo states 2026-03-08 22:44:44.437562 | Merging changes 2026-03-08 22:44:44.437581 | Checking out repos 2026-03-08 22:44:44.508405 | Preparing playbooks 2026-03-08 22:44:45.147965 | Running Ansible setup 2026-03-08 22:44:51.019747 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-08 22:44:51.814360 | 2026-03-08 22:44:51.814568 | PLAY [Base pre] 2026-03-08 22:44:51.833122 | 2026-03-08 22:44:51.833295 | TASK [Setup log path fact] 2026-03-08 22:44:51.865718 | noble | ok 2026-03-08 22:44:51.884766 | 2026-03-08 22:44:51.884992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-08 22:44:51.929645 | noble | ok 2026-03-08 22:44:51.942625 | 2026-03-08 22:44:51.942750 | TASK [emit-job-header : Print job information] 2026-03-08 22:44:51.999080 | # Job Information 2026-03-08 22:44:51.999367 | Ansible Version: 2.16.14 2026-03-08 22:44:51.999419 | Job: openstack-ironic-images-publish-osism-node 2026-03-08 22:44:51.999468 | Pipeline: post 2026-03-08 22:44:51.999505 | Executor: 521e9411259a 2026-03-08 22:44:51.999537 | Triggered by: https://github.com/osism/openstack-ironic-images/commit/826c89d183bb105384ef1a2ed4f3f47b0bcd4aac 2026-03-08 22:44:51.999571 | Event ID: fdad9a12-1b3f-11f1-9811-09f29e62c8f1 2026-03-08 22:44:52.008385 | 2026-03-08 22:44:52.008513 | LOOP [emit-job-header : Print node information] 2026-03-08 22:44:52.141180 | noble | ok: 2026-03-08 22:44:52.141503 | noble | # Node Information 2026-03-08 22:44:52.141567 | noble | Inventory Hostname: noble 2026-03-08 22:44:52.141622 | noble | Hostname: ubuntu 2026-03-08 22:44:52.141659 | noble | Username: zuul 2026-03-08 22:44:52.141693 | noble | Distro: Ubuntu 24.04 2026-03-08 22:44:52.141732 | noble | Provider: regiocloud-a 2026-03-08 22:44:52.141767 | noble | Region: 2026-03-08 22:44:52.141829 | noble | Label: ubuntu-noble-uefi 2026-03-08 22:44:52.141863 | noble | Product Name: OpenStack Nova 2026-03-08 22:44:52.141896 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0f:8fb 2026-03-08 22:44:52.169591 | 2026-03-08 22:44:52.169844 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-08 22:44:52.701730 | noble -> localhost | changed 2026-03-08 22:44:52.711466 | 2026-03-08 22:44:52.711617 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-08 22:44:53.835689 | noble -> localhost | changed 2026-03-08 22:44:53.858443 | 2026-03-08 22:44:53.858583 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-08 22:44:54.170037 | noble -> localhost | ok 2026-03-08 22:44:54.180978 | 2026-03-08 22:44:54.181136 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-08 22:44:54.225311 | noble | ok 2026-03-08 22:44:54.244729 | noble | included: /var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-08 22:44:54.253423 | 2026-03-08 22:44:54.253534 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-08 22:44:55.926036 | noble -> localhost | Generating public/private rsa key pair. 2026-03-08 22:44:55.926726 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/5eedf9db62c54c79928d5649c071fe4b_id_rsa 2026-03-08 22:44:55.926930 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/5eedf9db62c54c79928d5649c071fe4b_id_rsa.pub 2026-03-08 22:44:55.927013 | noble -> localhost | The key fingerprint is: 2026-03-08 22:44:55.927084 | noble -> localhost | SHA256:e9CLO6Qzvjj9Fmc6R397tK9vODehKPihpThkgvR/gRA zuul-build-sshkey 2026-03-08 22:44:55.927148 | noble -> localhost | The key's randomart image is: 2026-03-08 22:44:55.927209 | noble -> localhost | +---[RSA 3072]----+ 2026-03-08 22:44:55.927271 | noble -> localhost | | | 2026-03-08 22:44:55.927379 | noble -> localhost | | E | 2026-03-08 22:44:55.927488 | noble -> localhost | | . | 2026-03-08 22:44:55.927596 | noble -> localhost | | . . . | 2026-03-08 22:44:55.927691 | noble -> localhost | |. o . . S . | 2026-03-08 22:44:55.927797 | noble -> localhost | | . o + .o++. ..| 2026-03-08 22:44:55.927863 | noble -> localhost | | =. o=Oo.. .oo| 2026-03-08 22:44:55.927923 | noble -> localhost | | .+*oO+o...+o+| 2026-03-08 22:44:55.927983 | noble -> localhost | | .+=O+=. .oO=| 2026-03-08 22:44:55.928040 | noble -> localhost | +----[SHA256]-----+ 2026-03-08 22:44:55.928182 | noble -> localhost | ok: Runtime: 0:00:01.138340 2026-03-08 22:44:55.943607 | 2026-03-08 22:44:55.943760 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-08 22:44:55.982945 | noble | ok 2026-03-08 22:44:55.997280 | noble | included: /var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-08 22:44:56.007213 | 2026-03-08 22:44:56.007320 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-08 22:44:56.031846 | noble | skipping: Conditional result was False 2026-03-08 22:44:56.039821 | 2026-03-08 22:44:56.039925 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-08 22:44:56.677862 | noble | changed 2026-03-08 22:44:56.686895 | 2026-03-08 22:44:56.687025 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-08 22:44:56.997441 | noble | ok 2026-03-08 22:44:57.006298 | 2026-03-08 22:44:57.006429 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-08 22:44:57.811505 | noble | changed 2026-03-08 22:44:57.818479 | 2026-03-08 22:44:57.818611 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-08 22:44:58.613061 | noble | changed 2026-03-08 22:44:58.624181 | 2026-03-08 22:44:58.624316 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-08 22:44:58.659862 | noble | skipping: Conditional result was False 2026-03-08 22:44:58.673512 | 2026-03-08 22:44:58.673674 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-08 22:44:59.156160 | noble -> localhost | changed 2026-03-08 22:44:59.182866 | 2026-03-08 22:44:59.183024 | TASK [add-build-sshkey : Add back temp key] 2026-03-08 22:44:59.532654 | noble -> localhost | Identity added: /var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/5eedf9db62c54c79928d5649c071fe4b_id_rsa (zuul-build-sshkey) 2026-03-08 22:44:59.533269 | noble -> localhost | ok: Runtime: 0:00:00.017024 2026-03-08 22:44:59.548130 | 2026-03-08 22:44:59.548285 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-08 22:45:00.022891 | noble | ok 2026-03-08 22:45:00.030537 | 2026-03-08 22:45:00.030716 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-08 22:45:00.066645 | noble | skipping: Conditional result was False 2026-03-08 22:45:00.136721 | 2026-03-08 22:45:00.136923 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-08 22:45:00.581489 | noble | ok 2026-03-08 22:45:00.599331 | 2026-03-08 22:45:00.599527 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-08 22:45:00.644110 | noble | ok 2026-03-08 22:45:00.653095 | 2026-03-08 22:45:00.653211 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-08 22:45:00.982959 | noble -> localhost | ok 2026-03-08 22:45:00.998609 | 2026-03-08 22:45:00.998791 | TASK [validate-host : Collect information about the host] 2026-03-08 22:45:02.464372 | noble | ok 2026-03-08 22:45:02.481457 | 2026-03-08 22:45:02.481585 | TASK [validate-host : Sanitize hostname] 2026-03-08 22:45:02.547948 | noble | ok 2026-03-08 22:45:02.556468 | 2026-03-08 22:45:02.556606 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-08 22:45:03.144591 | noble -> localhost | changed 2026-03-08 22:45:03.154271 | 2026-03-08 22:45:03.154463 | TASK [validate-host : Collect information about zuul worker] 2026-03-08 22:45:03.659503 | noble | ok 2026-03-08 22:45:03.667681 | 2026-03-08 22:45:03.667899 | TASK [validate-host : Write out all zuul information for each host] 2026-03-08 22:45:04.268832 | noble -> localhost | changed 2026-03-08 22:45:04.280299 | 2026-03-08 22:45:04.280407 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-08 22:45:04.629260 | noble | ok 2026-03-08 22:45:04.638193 | 2026-03-08 22:45:04.638317 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-08 22:45:05.659547 | noble | changed: 2026-03-08 22:45:05.659945 | noble | cd+++++++++ src/ 2026-03-08 22:45:05.660004 | noble | cd+++++++++ src/github.com/ 2026-03-08 22:45:05.660045 | noble | cd+++++++++ src/github.com/osism/ 2026-03-08 22:45:05.660080 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-03-08 22:45:05.660113 | noble | localhost | ok: "/var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/logs" 2026-03-08 23:00:27.644629 | noble -> localhost | changed: "/var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/artifacts" 2026-03-08 23:00:27.917740 | noble -> localhost | changed: "/var/lib/zuul/builds/5eedf9db62c54c79928d5649c071fe4b/work/docs" 2026-03-08 23:00:27.942014 | 2026-03-08 23:00:27.942192 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-08 23:00:29.271559 | noble | changed: 2026-03-08 23:00:29.271908 | noble | .d..t...... ./ 2026-03-08 23:00:29.271950 | noble | >f+++++++++ osism-node.log 2026-03-08 23:00:29.272004 | noble | changed: All items complete 2026-03-08 23:00:29.272037 | 2026-03-08 23:00:29.940939 | noble | changed: .d..t...... ./ 2026-03-08 23:00:30.629264 | noble | changed: .d..t...... ./ 2026-03-08 23:00:30.651101 | 2026-03-08 23:00:30.651259 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-08 23:00:30.693434 | noble | skipping: Conditional result was False 2026-03-08 23:00:30.697305 | noble | skipping: Conditional result was False 2026-03-08 23:00:30.710603 | 2026-03-08 23:00:30.710737 | PLAY RECAP 2026-03-08 23:00:30.710806 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-08 23:00:30.710862 | 2026-03-08 23:00:30.857123 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-03-08 23:00:30.858192 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-08 23:00:31.617195 | 2026-03-08 23:00:31.617420 | PLAY [Base post] 2026-03-08 23:00:31.633850 | 2026-03-08 23:00:31.634010 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-08 23:00:32.304968 | noble | changed 2026-03-08 23:00:32.315717 | 2026-03-08 23:00:32.315885 | PLAY RECAP 2026-03-08 23:00:32.315960 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-08 23:00:32.316039 | 2026-03-08 23:00:32.433632 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-08 23:00:32.434603 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-08 23:00:33.238465 | 2026-03-08 23:00:33.238656 | PLAY [Base post-logs] 2026-03-08 23:00:33.249782 | 2026-03-08 23:00:33.249923 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-08 23:00:33.726130 | localhost | changed 2026-03-08 23:00:33.736905 | 2026-03-08 23:00:33.737069 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-08 23:00:33.787311 | localhost | ok 2026-03-08 23:00:33.793700 | 2026-03-08 23:00:33.793856 | TASK [Set zuul-log-path fact] 2026-03-08 23:00:33.812517 | localhost | ok 2026-03-08 23:00:33.824651 | 2026-03-08 23:00:33.824835 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-08 23:00:33.852776 | localhost | ok 2026-03-08 23:00:33.856198 | 2026-03-08 23:00:33.856310 | TASK [upload-logs : Create log directories] 2026-03-08 23:00:34.428115 | localhost | changed 2026-03-08 23:00:34.432565 | 2026-03-08 23:00:34.432760 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-08 23:00:34.966133 | localhost -> localhost | ok: Runtime: 0:00:00.007329 2026-03-08 23:00:34.975841 | 2026-03-08 23:00:34.976045 | TASK [upload-logs : Upload logs to log server] 2026-03-08 23:00:35.603839 | localhost | Output suppressed because no_log was given 2026-03-08 23:00:35.605867 | 2026-03-08 23:00:35.605977 | LOOP [upload-logs : Compress console log and json output] 2026-03-08 23:00:35.659211 | localhost | skipping: Conditional result was False 2026-03-08 23:00:35.664439 | localhost | skipping: Conditional result was False 2026-03-08 23:00:35.677344 | 2026-03-08 23:00:35.677535 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-08 23:00:35.726073 | localhost | skipping: Conditional result was False 2026-03-08 23:00:35.726714 | 2026-03-08 23:00:35.730081 | localhost | skipping: Conditional result was False 2026-03-08 23:00:35.737482 | 2026-03-08 23:00:35.737725 | LOOP [upload-logs : Upload console log and json output]