2026-10-02 12:18:25.928873 | Job console starting 2026-10-02 12:18:25.956575 | Updating git repos 2026-10-02 12:18:26.032290 | Cloning repos into workspace 2026-10-02 12:18:26.183965 | Restoring repo states 2026-10-02 12:18:26.193541 | Merging changes 2026-10-02 12:18:27.309805 | Checking out repos 2026-10-02 12:18:27.497380 | Preparing playbooks 2026-10-02 12:18:30.430488 | Running Ansible setup 2026-10-02 12:18:38.169078 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-02 12:18:40.593158 | 2026-10-02 12:18:40.593281 | PLAY [Base pre] 2026-10-02 12:18:40.692245 | 2026-10-02 12:18:40.692362 | TASK [Setup log path fact] 2026-10-02 12:18:40.723333 | ubuntu-noble | ok 2026-10-02 12:18:40.817188 | 2026-10-02 12:18:40.817310 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 12:18:40.925995 | ubuntu-noble | ok 2026-10-02 12:18:40.937382 | 2026-10-02 12:18:40.937472 | TASK [emit-job-header : Print job information] 2026-10-02 12:18:41.040187 | # Job Information 2026-10-02 12:18:41.040329 | Ansible Version: 2.16.14 2026-10-02 12:18:41.040356 | Job: metalbox-unittest 2026-10-02 12:18:41.040382 | Pipeline: check 2026-10-02 12:18:41.040401 | Executor: 521e9411259a 2026-10-02 12:18:41.040418 | Triggered by: https://github.com/osism/metalbox/pull/392 2026-10-02 12:18:41.040436 | Event ID: 6bf88820-be5a-11f1-921d-b0d0ec24831b 2026-10-02 12:18:41.058768 | 2026-10-02 12:18:41.058868 | LOOP [emit-job-header : Print node information] 2026-10-02 12:18:41.328538 | ubuntu-noble | ok: 2026-10-02 12:18:41.328676 | ubuntu-noble | # Node Information 2026-10-02 12:18:41.328704 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2026-10-02 12:18:41.328725 | ubuntu-noble | Hostname: ubuntu 2026-10-02 12:18:41.328743 | ubuntu-noble | Username: zuul 2026-10-02 12:18:41.328760 | ubuntu-noble | Distro: Ubuntu 24.04 2026-10-02 12:18:41.328780 | ubuntu-noble | Provider: regiocloud-a 2026-10-02 12:18:41.328798 | ubuntu-noble | Region: 2026-10-02 12:18:41.328815 | ubuntu-noble | Label: ubuntu-noble 2026-10-02 12:18:41.328832 | ubuntu-noble | Product Name: OpenStack Nova 2026-10-02 12:18:41.328848 | ubuntu-noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe35:6ec4 2026-10-02 12:18:41.342595 | 2026-10-02 12:18:41.342695 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-02 12:18:42.544610 | ubuntu-noble -> localhost | changed 2026-10-02 12:18:42.550506 | 2026-10-02 12:18:42.550649 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-02 12:18:44.892999 | ubuntu-noble -> localhost | changed 2026-10-02 12:18:44.906210 | 2026-10-02 12:18:44.906360 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-02 12:18:45.545489 | ubuntu-noble -> localhost | ok 2026-10-02 12:18:45.551632 | 2026-10-02 12:18:45.551718 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-02 12:18:45.611795 | ubuntu-noble | ok 2026-10-02 12:18:45.668560 | ubuntu-noble | included: /var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-02 12:18:45.735836 | 2026-10-02 12:18:45.735946 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-02 12:18:48.346401 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-10-02 12:18:48.346558 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/1bcbeb9457f3408989d6af024ac340de_id_rsa 2026-10-02 12:18:48.346589 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/1bcbeb9457f3408989d6af024ac340de_id_rsa.pub 2026-10-02 12:18:48.346610 | ubuntu-noble -> localhost | The key fingerprint is: 2026-10-02 12:18:48.346629 | ubuntu-noble -> localhost | SHA256:it1feHAaR8M3BniHxfhbItDK/lFaFdjolqkkn8AGcUw zuul-build-sshkey 2026-10-02 12:18:48.346647 | ubuntu-noble -> localhost | The key's randomart image is: 2026-10-02 12:18:48.346664 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-10-02 12:18:48.346689 | ubuntu-noble -> localhost | | .+E o.==..| 2026-10-02 12:18:48.346707 | ubuntu-noble -> localhost | | ...o.=+o..| 2026-10-02 12:18:48.346723 | ubuntu-noble -> localhost | | o. +=o*. | 2026-10-02 12:18:48.346739 | ubuntu-noble -> localhost | | =oo.O=..| 2026-10-02 12:18:48.346755 | ubuntu-noble -> localhost | | S.B *= + | 2026-10-02 12:18:48.346788 | ubuntu-noble -> localhost | | o o .@o . | 2026-10-02 12:18:48.346807 | ubuntu-noble -> localhost | | . o . o.o. | 2026-10-02 12:18:48.346824 | ubuntu-noble -> localhost | | . o. | 2026-10-02 12:18:48.346842 | ubuntu-noble -> localhost | | . | 2026-10-02 12:18:48.346859 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-10-02 12:18:48.346921 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.387931 2026-10-02 12:18:48.352235 | 2026-10-02 12:18:48.352309 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-02 12:18:48.388350 | ubuntu-noble | ok 2026-10-02 12:18:48.396647 | ubuntu-noble | included: /var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-02 12:18:48.437926 | 2026-10-02 12:18:48.438012 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-02 12:18:48.482734 | ubuntu-noble | skipping: Conditional result was False 2026-10-02 12:18:48.487488 | 2026-10-02 12:18:48.487567 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-02 12:18:49.526326 | ubuntu-noble | changed 2026-10-02 12:18:49.530629 | 2026-10-02 12:18:49.530704 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-02 12:18:49.895574 | ubuntu-noble | ok 2026-10-02 12:18:49.899940 | 2026-10-02 12:18:49.900012 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-02 12:18:50.810693 | ubuntu-noble | changed 2026-10-02 12:18:50.815240 | 2026-10-02 12:18:50.815312 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-02 12:18:51.571522 | ubuntu-noble | changed 2026-10-02 12:18:51.578839 | 2026-10-02 12:18:51.578960 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-02 12:18:51.612787 | ubuntu-noble | skipping: Conditional result was False 2026-10-02 12:18:51.619262 | 2026-10-02 12:18:51.619368 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-02 12:18:52.262372 | ubuntu-noble -> localhost | changed 2026-10-02 12:18:52.281959 | 2026-10-02 12:18:52.282053 | TASK [add-build-sshkey : Add back temp key] 2026-10-02 12:18:52.993695 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/1bcbeb9457f3408989d6af024ac340de_id_rsa (zuul-build-sshkey) 2026-10-02 12:18:52.993911 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.036299 2026-10-02 12:18:53.002049 | 2026-10-02 12:18:53.002142 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-02 12:18:53.646632 | ubuntu-noble | ok 2026-10-02 12:18:53.654428 | 2026-10-02 12:18:53.654527 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-02 12:18:53.719007 | ubuntu-noble | skipping: Conditional result was False 2026-10-02 12:18:53.729116 | 2026-10-02 12:18:53.729206 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-02 12:18:54.661445 | ubuntu-noble | ok 2026-10-02 12:18:54.676162 | 2026-10-02 12:18:54.676251 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-02 12:18:54.762087 | ubuntu-noble | ok 2026-10-02 12:18:54.766976 | 2026-10-02 12:18:54.767053 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-02 12:18:55.267796 | ubuntu-noble -> localhost | ok 2026-10-02 12:18:55.279207 | 2026-10-02 12:18:55.279313 | TASK [validate-host : Collect information about the host] 2026-10-02 12:18:57.167994 | ubuntu-noble | ok 2026-10-02 12:18:57.179442 | 2026-10-02 12:18:57.179533 | TASK [validate-host : Sanitize hostname] 2026-10-02 12:18:57.489387 | ubuntu-noble | ok 2026-10-02 12:18:57.494801 | 2026-10-02 12:18:57.494896 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-02 12:18:59.410967 | ubuntu-noble -> localhost | changed 2026-10-02 12:18:59.415581 | 2026-10-02 12:18:59.415657 | TASK [validate-host : Collect information about zuul worker] 2026-10-02 12:19:00.162627 | ubuntu-noble | ok 2026-10-02 12:19:00.166475 | 2026-10-02 12:19:00.166603 | TASK [validate-host : Write out all zuul information for each host] 2026-10-02 12:19:01.398807 | ubuntu-noble -> localhost | changed 2026-10-02 12:19:01.406231 | 2026-10-02 12:19:01.406308 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-02 12:19:01.724559 | ubuntu-noble | ok 2026-10-02 12:19:01.729300 | 2026-10-02 12:19:01.729378 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-02 12:19:03.321048 | ubuntu-noble | changed: 2026-10-02 12:19:03.321195 | ubuntu-noble | cd+++++++++ src/ 2026-10-02 12:19:03.321223 | ubuntu-noble | cd+++++++++ src/github.com/ 2026-10-02 12:19:03.321244 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2026-10-02 12:19:03.321262 | ubuntu-noble | cd+++++++++ src/github.com/osism/metalbox/ 2026-10-02 12:19:03.321279 | ubuntu-noble | Containerfile 2026-10-02 12:19:03.392610 | ubuntu-noble | localhost | ok: "/var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/logs" 2026-10-02 12:19:59.561137 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/artifacts" 2026-10-02 12:19:59.794432 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1bcbeb9457f3408989d6af024ac340de/work/docs" 2026-10-02 12:19:59.811723 | 2026-10-02 12:19:59.811880 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-02 12:20:00.486468 | ubuntu-noble | changed: 2026-10-02 12:20:00.486692 | ubuntu-noble | .d..t...... ./ 2026-10-02 12:20:00.486735 | ubuntu-noble | >f+++++++++ net-debug.post.txt 2026-10-02 12:20:00.486765 | ubuntu-noble | >f+++++++++ net-debug.pre.txt 2026-10-02 12:20:00.486805 | ubuntu-noble | >f+++++++++ sudo-debug.txt 2026-10-02 12:20:00.486831 | ubuntu-noble | >f+++++++++ sudo-strace.log 2026-10-02 12:20:00.486855 | ubuntu-noble | >f+++++++++ sudo-strace.log.time 2026-10-02 12:20:00.486896 | ubuntu-noble | changed: All items complete 2026-10-02 12:20:00.486927 | 2026-10-02 12:20:01.011368 | ubuntu-noble | changed: .d..t...... ./ 2026-10-02 12:20:01.541521 | ubuntu-noble | changed: .d..t...... ./ 2026-10-02 12:20:01.554641 | 2026-10-02 12:20:01.554759 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-02 12:20:01.891468 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.020392 2026-10-02 12:20:02.159042 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.005332 2026-10-02 12:20:02.175330 | 2026-10-02 12:20:02.175432 | PLAY RECAP 2026-10-02 12:20:02.175484 | ubuntu-noble | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-02 12:20:02.175509 | 2026-10-02 12:20:02.323219 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-02 12:20:02.324153 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 12:20:03.088855 | 2026-10-02 12:20:03.089044 | PLAY [Base post] 2026-10-02 12:20:03.103513 | 2026-10-02 12:20:03.103642 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-02 12:20:03.770052 | ubuntu-noble | changed 2026-10-02 12:20:03.776358 | 2026-10-02 12:20:03.776465 | PLAY RECAP 2026-10-02 12:20:03.776529 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-02 12:20:03.776590 | 2026-10-02 12:20:03.891703 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 12:20:03.892638 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-02 12:20:04.647914 | 2026-10-02 12:20:04.648069 | PLAY [Base post-logs] 2026-10-02 12:20:04.658430 | 2026-10-02 12:20:04.658555 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-02 12:20:05.109656 | localhost | changed 2026-10-02 12:20:05.125160 | 2026-10-02 12:20:05.125285 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-02 12:20:05.161406 | localhost | ok 2026-10-02 12:20:05.166168 | 2026-10-02 12:20:05.166280 | TASK [Set zuul-log-path fact] 2026-10-02 12:20:05.181267 | localhost | ok 2026-10-02 12:20:05.188391 | 2026-10-02 12:20:05.188479 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 12:20:05.223406 | localhost | ok 2026-10-02 12:20:05.229053 | 2026-10-02 12:20:05.229189 | TASK [upload-logs : Create log directories] 2026-10-02 12:20:05.711267 | localhost | changed 2026-10-02 12:20:05.713823 | 2026-10-02 12:20:05.713908 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-02 12:20:06.132230 | localhost -> localhost | ok: Runtime: 0:00:00.005324 2026-10-02 12:20:06.135736 | 2026-10-02 12:20:06.135840 | TASK [upload-logs : Upload logs to log server] 2026-10-02 12:20:06.748905 | localhost | Output suppressed because no_log was given 2026-10-02 12:20:06.750590 | 2026-10-02 12:20:06.750677 | LOOP [upload-logs : Compress console log and json output] 2026-10-02 12:20:06.812411 | localhost | skipping: Conditional result was False 2026-10-02 12:20:06.819655 | localhost | skipping: Conditional result was False 2026-10-02 12:20:06.822688 | 2026-10-02 12:20:06.822818 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-02 12:20:06.878312 | localhost | skipping: Conditional result was False 2026-10-02 12:20:06.878535 | 2026-10-02 12:20:06.884735 | localhost | skipping: Conditional result was False 2026-10-02 12:20:06.892138 | 2026-10-02 12:20:06.892227 | LOOP [upload-logs : Upload console log and json output]