2026-03-12 18:15:32.613782 | Job console starting 2026-03-12 18:15:32.641431 | Updating git repos 2026-03-12 18:15:32.664451 | Cloning repos into workspace 2026-03-12 18:15:32.713641 | Restoring repo states 2026-03-12 18:15:32.722035 | Merging changes 2026-03-12 18:15:32.722054 | Checking out repos 2026-03-12 18:15:32.760877 | Preparing playbooks 2026-03-12 18:15:33.366737 | Running Ansible setup 2026-03-12 18:15:39.125174 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-12 18:15:39.849849 | 2026-03-12 18:15:39.850006 | PLAY [Base pre] 2026-03-12 18:15:39.866822 | 2026-03-12 18:15:39.866979 | TASK [Setup log path fact] 2026-03-12 18:15:39.896765 | noble | ok 2026-03-12 18:15:39.913987 | 2026-03-12 18:15:39.914131 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-12 18:15:39.956211 | noble | ok 2026-03-12 18:15:39.971577 | 2026-03-12 18:15:39.971707 | TASK [emit-job-header : Print job information] 2026-03-12 18:15:40.013602 | # Job Information 2026-03-12 18:15:40.013932 | Ansible Version: 2.16.14 2026-03-12 18:15:40.013983 | Job: openstack-ironic-images-publish-osism-node 2026-03-12 18:15:40.014027 | Pipeline: periodic-weekly 2026-03-12 18:15:40.014057 | Executor: 521e9411259a 2026-03-12 18:15:40.014083 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-03-12 18:15:40.014111 | Event ID: 1a3c02823ef347b7996c445a4612e001 2026-03-12 18:15:40.023157 | 2026-03-12 18:15:40.023318 | LOOP [emit-job-header : Print node information] 2026-03-12 18:15:40.143112 | noble | ok: 2026-03-12 18:15:40.143388 | noble | # Node Information 2026-03-12 18:15:40.143427 | noble | Inventory Hostname: noble 2026-03-12 18:15:40.143451 | noble | Hostname: ubuntu 2026-03-12 18:15:40.143473 | noble | Username: zuul 2026-03-12 18:15:40.143493 | noble | Distro: Ubuntu 24.04 2026-03-12 18:15:40.143516 | noble | Provider: regiocloud-a 2026-03-12 18:15:40.143537 | noble | Region: 2026-03-12 18:15:40.143558 | noble | Label: ubuntu-noble-uefi 2026-03-12 18:15:40.143577 | noble | Product Name: OpenStack Nova 2026-03-12 18:15:40.143599 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea8:e509 2026-03-12 18:15:40.162473 | 2026-03-12 18:15:40.162620 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-12 18:15:40.651874 | noble -> localhost | changed 2026-03-12 18:15:40.660295 | 2026-03-12 18:15:40.660422 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-12 18:15:41.750487 | noble -> localhost | changed 2026-03-12 18:15:41.769642 | 2026-03-12 18:15:41.769872 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-12 18:15:42.074448 | noble -> localhost | ok 2026-03-12 18:15:42.081707 | 2026-03-12 18:15:42.081828 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-12 18:15:42.111947 | noble | ok 2026-03-12 18:15:42.128568 | noble | included: /var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-12 18:15:42.136882 | 2026-03-12 18:15:42.136992 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-12 18:15:44.240873 | noble -> localhost | Generating public/private rsa key pair. 2026-03-12 18:15:44.241090 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/e6171444482f49f784b8bfb003b6c86b_id_rsa 2026-03-12 18:15:44.241130 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/e6171444482f49f784b8bfb003b6c86b_id_rsa.pub 2026-03-12 18:15:44.241179 | noble -> localhost | The key fingerprint is: 2026-03-12 18:15:44.241207 | noble -> localhost | SHA256:CxraXn1EOMUNtVRGqMRdrwTfkhhWMs00vcht0FE6Xew zuul-build-sshkey 2026-03-12 18:15:44.241231 | noble -> localhost | The key's randomart image is: 2026-03-12 18:15:44.241252 | noble -> localhost | +---[RSA 3072]----+ 2026-03-12 18:15:44.241274 | noble -> localhost | | oo=OXX+=| 2026-03-12 18:15:44.241307 | noble -> localhost | | o+o+@oO+| 2026-03-12 18:15:44.241329 | noble -> localhost | | o...+ @.=| 2026-03-12 18:15:44.241349 | noble -> localhost | | o. + BE| 2026-03-12 18:15:44.241369 | noble -> localhost | | . . S . o | 2026-03-12 18:15:44.241396 | noble -> localhost | | o o o o | 2026-03-12 18:15:44.241416 | noble -> localhost | | . o . o . | 2026-03-12 18:15:44.241435 | noble -> localhost | | . . . | 2026-03-12 18:15:44.241456 | noble -> localhost | | . | 2026-03-12 18:15:44.241476 | noble -> localhost | +----[SHA256]-----+ 2026-03-12 18:15:44.241528 | noble -> localhost | ok: Runtime: 0:00:01.562097 2026-03-12 18:15:44.249307 | 2026-03-12 18:15:44.249431 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-12 18:15:44.279876 | noble | ok 2026-03-12 18:15:44.290085 | noble | included: /var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-12 18:15:44.299573 | 2026-03-12 18:15:44.299713 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-12 18:15:44.324414 | noble | skipping: Conditional result was False 2026-03-12 18:15:44.338225 | 2026-03-12 18:15:44.338404 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-12 18:15:44.926757 | noble | changed 2026-03-12 18:15:44.933340 | 2026-03-12 18:15:44.933457 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-12 18:15:45.220617 | noble | ok 2026-03-12 18:15:45.230536 | 2026-03-12 18:15:45.230696 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-12 18:15:45.992819 | noble | changed 2026-03-12 18:15:45.999463 | 2026-03-12 18:15:45.999576 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-12 18:15:46.816607 | noble | changed 2026-03-12 18:15:46.824823 | 2026-03-12 18:15:46.824942 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-12 18:15:46.848651 | noble | skipping: Conditional result was False 2026-03-12 18:15:46.856086 | 2026-03-12 18:15:46.856236 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-12 18:15:47.415846 | noble -> localhost | changed 2026-03-12 18:15:47.429891 | 2026-03-12 18:15:47.430027 | TASK [add-build-sshkey : Add back temp key] 2026-03-12 18:15:47.773577 | noble -> localhost | Identity added: /var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/e6171444482f49f784b8bfb003b6c86b_id_rsa (zuul-build-sshkey) 2026-03-12 18:15:47.773825 | noble -> localhost | ok: Runtime: 0:00:00.017112 2026-03-12 18:15:47.781449 | 2026-03-12 18:15:47.781564 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-12 18:15:48.254405 | noble | ok 2026-03-12 18:15:48.263614 | 2026-03-12 18:15:48.263762 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-12 18:15:48.288269 | noble | skipping: Conditional result was False 2026-03-12 18:15:48.344229 | 2026-03-12 18:15:48.344365 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-12 18:15:48.774664 | noble | ok 2026-03-12 18:15:48.789478 | 2026-03-12 18:15:48.789614 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-12 18:15:48.819169 | noble | ok 2026-03-12 18:15:48.826513 | 2026-03-12 18:15:48.826636 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-12 18:15:49.097396 | noble -> localhost | ok 2026-03-12 18:15:49.105504 | 2026-03-12 18:15:49.105625 | TASK [validate-host : Collect information about the host] 2026-03-12 18:15:50.601064 | noble | ok 2026-03-12 18:15:50.619901 | 2026-03-12 18:15:50.620036 | TASK [validate-host : Sanitize hostname] 2026-03-12 18:15:50.690076 | noble | ok 2026-03-12 18:15:50.696525 | 2026-03-12 18:15:50.696644 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-12 18:15:51.299215 | noble -> localhost | changed 2026-03-12 18:15:51.312968 | 2026-03-12 18:15:51.313170 | TASK [validate-host : Collect information about zuul worker] 2026-03-12 18:15:51.806033 | noble | ok 2026-03-12 18:15:51.816853 | 2026-03-12 18:15:51.817038 | TASK [validate-host : Write out all zuul information for each host] 2026-03-12 18:15:52.357855 | noble -> localhost | changed 2026-03-12 18:15:52.369090 | 2026-03-12 18:15:52.369266 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-12 18:15:52.698732 | noble | ok 2026-03-12 18:15:52.708369 | 2026-03-12 18:15:52.708494 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-12 18:15:53.678220 | noble | changed: 2026-03-12 18:15:53.678429 | noble | cd+++++++++ src/ 2026-03-12 18:15:53.678466 | noble | cd+++++++++ src/github.com/ 2026-03-12 18:15:53.678491 | noble | cd+++++++++ src/github.com/osism/ 2026-03-12 18:15:53.678512 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-03-12 18:15:53.678531 | noble | localhost | ok: "/var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/logs" 2026-03-12 18:30:31.179216 | noble -> localhost | changed: "/var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/artifacts" 2026-03-12 18:30:31.465852 | noble -> localhost | changed: "/var/lib/zuul/builds/e6171444482f49f784b8bfb003b6c86b/work/docs" 2026-03-12 18:30:31.495795 | 2026-03-12 18:30:31.496006 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-12 18:30:32.804704 | noble | changed: 2026-03-12 18:30:32.805117 | noble | .d..t...... ./ 2026-03-12 18:30:32.805182 | noble | >f+++++++++ osism-node.log 2026-03-12 18:30:32.805257 | noble | changed: All items complete 2026-03-12 18:30:32.805308 | 2026-03-12 18:30:33.495556 | noble | changed: .d..t...... ./ 2026-03-12 18:30:34.161388 | noble | changed: .d..t...... ./ 2026-03-12 18:30:34.190074 | 2026-03-12 18:30:34.190229 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-12 18:30:34.224750 | noble | skipping: Conditional result was False 2026-03-12 18:30:34.228237 | noble | skipping: Conditional result was False 2026-03-12 18:30:34.249865 | 2026-03-12 18:30:34.249992 | PLAY RECAP 2026-03-12 18:30:34.250070 | noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-12 18:30:34.250108 | 2026-03-12 18:30:34.387619 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-03-12 18:30:34.389869 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-12 18:30:35.141849 | 2026-03-12 18:30:35.142062 | PLAY [Base post] 2026-03-12 18:30:35.157032 | 2026-03-12 18:30:35.157181 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-12 18:30:35.846201 | noble | changed 2026-03-12 18:30:35.856480 | 2026-03-12 18:30:35.856609 | PLAY RECAP 2026-03-12 18:30:35.856683 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-12 18:30:35.856759 | 2026-03-12 18:30:35.982486 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-12 18:30:35.983471 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-12 18:30:36.761455 | 2026-03-12 18:30:36.761622 | PLAY [Base post-logs] 2026-03-12 18:30:36.772553 | 2026-03-12 18:30:36.772694 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-12 18:30:37.306302 | localhost | changed 2026-03-12 18:30:37.316470 | 2026-03-12 18:30:37.316626 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-12 18:30:37.341811 | localhost | ok 2026-03-12 18:30:37.345264 | 2026-03-12 18:30:37.345366 | TASK [Set zuul-log-path fact] 2026-03-12 18:30:37.360033 | localhost | ok 2026-03-12 18:30:37.368095 | 2026-03-12 18:30:37.368210 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-12 18:30:37.393599 | localhost | ok 2026-03-12 18:30:37.397418 | 2026-03-12 18:30:37.397528 | TASK [upload-logs : Create log directories] 2026-03-12 18:30:37.947703 | localhost | changed 2026-03-12 18:30:37.952241 | 2026-03-12 18:30:37.952366 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-12 18:30:38.515736 | localhost -> localhost | ok: Runtime: 0:00:00.014874 2026-03-12 18:30:38.521108 | 2026-03-12 18:30:38.521285 | TASK [upload-logs : Upload logs to log server] 2026-03-12 18:30:39.068832 | localhost | Output suppressed because no_log was given 2026-03-12 18:30:39.073091 | 2026-03-12 18:30:39.073279 | LOOP [upload-logs : Compress console log and json output] 2026-03-12 18:30:39.126709 | localhost | skipping: Conditional result was False 2026-03-12 18:30:39.132816 | localhost | skipping: Conditional result was False 2026-03-12 18:30:39.143391 | 2026-03-12 18:30:39.143524 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-12 18:30:39.197878 | localhost | skipping: Conditional result was False 2026-03-12 18:30:39.198581 | 2026-03-12 18:30:39.202828 | localhost | skipping: Conditional result was False 2026-03-12 18:30:39.210953 | 2026-03-12 18:30:39.211080 | LOOP [upload-logs : Upload console log and json output]