2026-04-29 03:18:57.734056 | Job console starting 2026-04-29 03:18:57.743127 | Updating git repos 2026-04-29 03:18:57.754582 | Cloning repos into workspace 2026-04-29 03:18:57.783833 | Restoring repo states 2026-04-29 03:18:57.789923 | Merging changes 2026-04-29 03:18:57.789938 | Checking out repos 2026-04-29 03:18:57.838651 | Preparing playbooks 2026-04-29 03:18:58.466976 | Running Ansible setup 2026-04-29 03:19:02.935213 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 03:19:03.695015 | 2026-04-29 03:19:03.695145 | PLAY [Base pre] 2026-04-29 03:19:03.711293 | 2026-04-29 03:19:03.711410 | TASK [Setup log path fact] 2026-04-29 03:19:03.730854 | debian-bookworm | ok 2026-04-29 03:19:03.746230 | 2026-04-29 03:19:03.746366 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 03:19:03.775256 | debian-bookworm | ok 2026-04-29 03:19:03.784537 | 2026-04-29 03:19:03.784635 | TASK [emit-job-header : Print job information] 2026-04-29 03:19:03.830487 | # Job Information 2026-04-29 03:19:03.830770 | Ansible Version: 2.16.14 2026-04-29 03:19:03.830861 | Job: terraform-base-validate-testbed-default 2026-04-29 03:19:03.830922 | Pipeline: periodic-daily 2026-04-29 03:19:03.830963 | Executor: 521e9411259a 2026-04-29 03:19:03.830999 | Triggered by: https://github.com/osism/terraform-base 2026-04-29 03:19:03.831036 | Event ID: ef62ad1a57d54fe19f673d35134774f2 2026-04-29 03:19:03.838558 | 2026-04-29 03:19:03.838715 | LOOP [emit-job-header : Print node information] 2026-04-29 03:19:03.953257 | debian-bookworm | ok: 2026-04-29 03:19:03.953442 | debian-bookworm | # Node Information 2026-04-29 03:19:03.953482 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-29 03:19:03.953512 | debian-bookworm | Hostname: debian 2026-04-29 03:19:03.953537 | debian-bookworm | Username: zuul 2026-04-29 03:19:03.953561 | debian-bookworm | Distro: Debian 12.13 2026-04-29 03:19:03.953590 | debian-bookworm | Provider: regiocloud-a 2026-04-29 03:19:03.953615 | debian-bookworm | Region: 2026-04-29 03:19:03.953640 | debian-bookworm | Label: debian-bookworm 2026-04-29 03:19:03.953662 | debian-bookworm | Product Name: OpenStack Nova 2026-04-29 03:19:03.953684 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:862c 2026-04-29 03:19:03.966109 | 2026-04-29 03:19:03.966219 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 03:19:04.428346 | debian-bookworm -> localhost | changed 2026-04-29 03:19:04.435311 | 2026-04-29 03:19:04.435420 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 03:19:05.873133 | debian-bookworm -> localhost | changed 2026-04-29 03:19:05.883684 | 2026-04-29 03:19:05.883797 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 03:19:06.260114 | debian-bookworm -> localhost | ok 2026-04-29 03:19:06.265956 | 2026-04-29 03:19:06.266049 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 03:19:06.306091 | debian-bookworm | ok 2026-04-29 03:19:06.320798 | debian-bookworm | included: /var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 03:19:06.326857 | 2026-04-29 03:19:06.326950 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 03:19:07.884025 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-29 03:19:07.884242 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/8774bb4a99da4c3bb3bbd04baf099ad0_id_rsa 2026-04-29 03:19:07.884279 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/8774bb4a99da4c3bb3bbd04baf099ad0_id_rsa.pub 2026-04-29 03:19:07.884305 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-29 03:19:07.884329 | debian-bookworm -> localhost | SHA256:M7YpwnUUcaVYyyJHZ1RDVkmQPR3rHAmTEYgPzRl/s78 zuul-build-sshkey 2026-04-29 03:19:07.884359 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-29 03:19:07.884382 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-29 03:19:07.884403 | debian-bookworm -> localhost | | +oX=@@*+.| 2026-04-29 03:19:07.884424 | debian-bookworm -> localhost | | . @ Ooo* +| 2026-04-29 03:19:07.884444 | debian-bookworm -> localhost | | . = * . B | 2026-04-29 03:19:07.884464 | debian-bookworm -> localhost | | + . . + +| 2026-04-29 03:19:07.884483 | debian-bookworm -> localhost | | . S + | 2026-04-29 03:19:07.884519 | debian-bookworm -> localhost | | . . o = .| 2026-04-29 03:19:07.884541 | debian-bookworm -> localhost | | o . o .| 2026-04-29 03:19:07.884570 | debian-bookworm -> localhost | | . . .| 2026-04-29 03:19:07.884592 | debian-bookworm -> localhost | | E | 2026-04-29 03:19:07.884612 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-29 03:19:07.884659 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.070445 2026-04-29 03:19:07.891449 | 2026-04-29 03:19:07.891546 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 03:19:07.910056 | debian-bookworm | ok 2026-04-29 03:19:07.919555 | debian-bookworm | included: /var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 03:19:07.928752 | 2026-04-29 03:19:07.928849 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 03:19:07.942093 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:19:07.947896 | 2026-04-29 03:19:07.948122 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 03:19:08.547209 | debian-bookworm | changed 2026-04-29 03:19:08.576685 | 2026-04-29 03:19:08.579846 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 03:19:08.862191 | debian-bookworm | ok 2026-04-29 03:19:08.870762 | 2026-04-29 03:19:08.870986 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 03:19:09.476189 | debian-bookworm | changed 2026-04-29 03:19:09.482611 | 2026-04-29 03:19:09.482723 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 03:19:10.108148 | debian-bookworm | changed 2026-04-29 03:19:10.113589 | 2026-04-29 03:19:10.113676 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 03:19:10.140275 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:19:10.146203 | 2026-04-29 03:19:10.146298 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 03:19:10.544915 | debian-bookworm -> localhost | changed 2026-04-29 03:19:10.558645 | 2026-04-29 03:19:10.558781 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 03:19:10.909456 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/8774bb4a99da4c3bb3bbd04baf099ad0_id_rsa (zuul-build-sshkey) 2026-04-29 03:19:10.909681 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009710 2026-04-29 03:19:10.918430 | 2026-04-29 03:19:10.918628 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 03:19:11.363642 | debian-bookworm | ok 2026-04-29 03:19:11.369263 | 2026-04-29 03:19:11.369359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 03:19:11.407007 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:19:11.419511 | 2026-04-29 03:19:11.419610 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-29 03:19:11.979592 | debian-bookworm | ok 2026-04-29 03:19:11.996627 | 2026-04-29 03:19:11.996767 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-29 03:19:12.036910 | debian-bookworm | ok 2026-04-29 03:19:12.042688 | 2026-04-29 03:19:12.042815 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-29 03:19:12.409886 | debian-bookworm -> localhost | ok 2026-04-29 03:19:12.416382 | 2026-04-29 03:19:12.416479 | TASK [validate-host : Collect information about the host] 2026-04-29 03:19:13.687900 | debian-bookworm | ok 2026-04-29 03:19:13.699818 | 2026-04-29 03:19:13.699911 | TASK [validate-host : Sanitize hostname] 2026-04-29 03:19:13.817291 | debian-bookworm | ok 2026-04-29 03:19:13.851888 | 2026-04-29 03:19:13.851993 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-29 03:19:14.430785 | debian-bookworm -> localhost | changed 2026-04-29 03:19:14.439239 | 2026-04-29 03:19:14.439342 | TASK [validate-host : Collect information about zuul worker] 2026-04-29 03:19:14.860809 | debian-bookworm | ok 2026-04-29 03:19:14.865537 | 2026-04-29 03:19:14.865637 | TASK [validate-host : Write out all zuul information for each host] 2026-04-29 03:19:15.437731 | debian-bookworm -> localhost | changed 2026-04-29 03:19:15.456023 | 2026-04-29 03:19:15.456138 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-29 03:19:15.695881 | debian-bookworm | ok 2026-04-29 03:19:15.701467 | 2026-04-29 03:19:15.701561 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-29 03:19:16.607814 | debian-bookworm | changed: 2026-04-29 03:19:16.607991 | debian-bookworm | cd+++++++++ src/ 2026-04-29 03:19:16.608025 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-29 03:19:16.608050 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-29 03:19:16.608071 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-04-29 03:19:16.608091 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/logs" 2026-04-29 03:19:32.556064 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/artifacts" 2026-04-29 03:19:32.979747 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8774bb4a99da4c3bb3bbd04baf099ad0/work/docs" 2026-04-29 03:19:32.989340 | 2026-04-29 03:19:32.989442 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 03:19:34.063481 | debian-bookworm | changed: 2026-04-29 03:19:34.063676 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-29 03:19:34.063726 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-29 03:19:34.063760 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-29 03:19:34.063801 | debian-bookworm | changed: All items complete 2026-04-29 03:19:34.063824 | 2026-04-29 03:19:34.699471 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 03:19:35.358061 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 03:19:35.372002 | 2026-04-29 03:19:35.372110 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 03:19:35.395103 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:19:35.399002 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:19:35.413961 | 2026-04-29 03:19:35.414036 | PLAY RECAP 2026-04-29 03:19:35.414085 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-04-29 03:19:35.414111 | 2026-04-29 03:19:35.517807 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-29 03:19:35.518558 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 03:19:36.283108 | 2026-04-29 03:19:36.283238 | PLAY [Base post] 2026-04-29 03:19:36.297135 | 2026-04-29 03:19:36.297253 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 03:19:36.855365 | debian-bookworm | changed 2026-04-29 03:19:36.869259 | 2026-04-29 03:19:36.869370 | PLAY RECAP 2026-04-29 03:19:36.869433 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 03:19:36.869493 | 2026-04-29 03:19:36.965448 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 03:19:36.966491 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 03:19:37.762101 | 2026-04-29 03:19:37.762237 | PLAY [Base post-logs] 2026-04-29 03:19:37.785176 | 2026-04-29 03:19:37.785306 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 03:19:38.294750 | localhost | changed 2026-04-29 03:19:38.304304 | 2026-04-29 03:19:38.304431 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 03:19:38.329033 | localhost | ok 2026-04-29 03:19:38.332166 | 2026-04-29 03:19:38.332250 | TASK [Set zuul-log-path fact] 2026-04-29 03:19:38.346427 | localhost | ok 2026-04-29 03:19:38.353635 | 2026-04-29 03:19:38.353757 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 03:19:38.378039 | localhost | ok 2026-04-29 03:19:38.380825 | 2026-04-29 03:19:38.380906 | TASK [upload-logs : Create log directories] 2026-04-29 03:19:39.316690 | localhost | changed 2026-04-29 03:19:39.320456 | 2026-04-29 03:19:39.320550 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 03:19:39.898828 | localhost -> localhost | ok: Runtime: 0:00:00.011556 2026-04-29 03:19:39.902302 | 2026-04-29 03:19:39.902392 | TASK [upload-logs : Upload logs to log server] 2026-04-29 03:19:40.605122 | localhost | Output suppressed because no_log was given 2026-04-29 03:19:40.607004 | 2026-04-29 03:19:40.607103 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 03:19:40.649583 | localhost | skipping: Conditional result was False 2026-04-29 03:19:40.655277 | localhost | skipping: Conditional result was False 2026-04-29 03:19:40.662495 | 2026-04-29 03:19:40.662599 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 03:19:40.710260 | localhost | skipping: Conditional result was False 2026-04-29 03:19:40.710494 | 2026-04-29 03:19:40.715240 | localhost | skipping: Conditional result was False 2026-04-29 03:19:40.718197 | 2026-04-29 03:19:40.718289 | LOOP [upload-logs : Upload console log and json output]