2026-09-15 03:05:37.413483 | Job console starting 2026-09-15 03:05:37.423481 | Updating git repos 2026-09-15 03:05:37.469146 | Cloning repos into workspace 2026-09-15 03:05:37.579212 | Restoring repo states 2026-09-15 03:05:37.585483 | Merging changes 2026-09-15 03:05:37.585498 | Checking out repos 2026-09-15 03:05:37.638655 | Preparing playbooks 2026-09-15 03:05:38.921498 | Running Ansible setup 2026-09-15 03:05:43.790207 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-15 03:05:44.809236 | 2026-09-15 03:05:44.809359 | PLAY [Base pre] 2026-09-15 03:05:44.837847 | 2026-09-15 03:05:44.837968 | TASK [Setup log path fact] 2026-09-15 03:05:44.865955 | debian-bookworm | ok 2026-09-15 03:05:44.882280 | 2026-09-15 03:05:44.882398 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 03:05:44.910001 | debian-bookworm | ok 2026-09-15 03:05:44.919470 | 2026-09-15 03:05:44.919635 | TASK [emit-job-header : Print job information] 2026-09-15 03:05:44.957751 | # Job Information 2026-09-15 03:05:44.957910 | Ansible Version: 2.16.14 2026-09-15 03:05:44.957945 | Job: terraform-base-validate-testbed-default 2026-09-15 03:05:44.957978 | Pipeline: periodic-daily 2026-09-15 03:05:44.958001 | Executor: 521e9411259a 2026-09-15 03:05:44.958022 | Triggered by: https://github.com/osism/terraform-base 2026-09-15 03:05:44.958045 | Event ID: aa9a7c7b3592440d81f646e7f9d5fe6f 2026-09-15 03:05:44.962954 | 2026-09-15 03:05:44.963042 | LOOP [emit-job-header : Print node information] 2026-09-15 03:05:45.060237 | debian-bookworm | ok: 2026-09-15 03:05:45.060378 | debian-bookworm | # Node Information 2026-09-15 03:05:45.060406 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-15 03:05:45.060427 | debian-bookworm | Hostname: debian 2026-09-15 03:05:45.060445 | debian-bookworm | Username: zuul 2026-09-15 03:05:45.060461 | debian-bookworm | Distro: Debian 12.15 2026-09-15 03:05:45.060482 | debian-bookworm | Provider: regiocloud-a 2026-09-15 03:05:45.060499 | debian-bookworm | Region: 2026-09-15 03:05:45.060540 | debian-bookworm | Label: debian-bookworm 2026-09-15 03:05:45.060559 | debian-bookworm | Product Name: OpenStack Nova 2026-09-15 03:05:45.060575 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee3:e4ad 2026-09-15 03:05:45.076898 | 2026-09-15 03:05:45.077004 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-15 03:05:45.534197 | debian-bookworm -> localhost | changed 2026-09-15 03:05:45.540853 | 2026-09-15 03:05:45.540949 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-15 03:05:46.667299 | debian-bookworm -> localhost | changed 2026-09-15 03:05:46.676058 | 2026-09-15 03:05:46.676145 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-15 03:05:46.944791 | debian-bookworm -> localhost | ok 2026-09-15 03:05:46.949689 | 2026-09-15 03:05:46.949774 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-15 03:05:46.977443 | debian-bookworm | ok 2026-09-15 03:05:46.989562 | debian-bookworm | included: /var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-15 03:05:46.994561 | 2026-09-15 03:05:46.994640 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-15 03:05:47.914111 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-15 03:05:47.914296 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/3c170a7296fa4892997f9b2e211bb35f_id_rsa 2026-09-15 03:05:47.914335 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/3c170a7296fa4892997f9b2e211bb35f_id_rsa.pub 2026-09-15 03:05:47.914362 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-15 03:05:47.914386 | debian-bookworm -> localhost | SHA256:vQSoQ0OJyjY4R6mxH5Zswp2SAkZGrNJxkY803sAn9vk zuul-build-sshkey 2026-09-15 03:05:47.914417 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-15 03:05:47.914439 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-15 03:05:47.914460 | debian-bookworm -> localhost | |++ +o+ | 2026-09-15 03:05:47.914482 | debian-bookworm -> localhost | |+o=.@ .. | 2026-09-15 03:05:47.914525 | debian-bookworm -> localhost | |BOoB+X... | 2026-09-15 03:05:47.914549 | debian-bookworm -> localhost | |@BO+oo= o | 2026-09-15 03:05:47.914569 | debian-bookworm -> localhost | |+Bo.o .S o | 2026-09-15 03:05:47.914594 | debian-bookworm -> localhost | | . . E. . | 2026-09-15 03:05:47.914614 | debian-bookworm -> localhost | | . | 2026-09-15 03:05:47.914633 | debian-bookworm -> localhost | | | 2026-09-15 03:05:47.914654 | debian-bookworm -> localhost | | | 2026-09-15 03:05:47.914674 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-15 03:05:47.914726 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.370435 2026-09-15 03:05:47.921752 | 2026-09-15 03:05:47.921852 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-15 03:05:47.939627 | debian-bookworm | ok 2026-09-15 03:05:47.953121 | debian-bookworm | included: /var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-15 03:05:47.960983 | 2026-09-15 03:05:47.961061 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-15 03:05:47.973693 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:05:47.981457 | 2026-09-15 03:05:47.981575 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-15 03:05:48.736548 | debian-bookworm | changed 2026-09-15 03:05:48.740952 | 2026-09-15 03:05:48.741023 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-15 03:05:49.030147 | debian-bookworm | ok 2026-09-15 03:05:49.038351 | 2026-09-15 03:05:49.038456 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-15 03:05:49.826183 | debian-bookworm | changed 2026-09-15 03:05:49.830396 | 2026-09-15 03:05:49.830468 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-15 03:05:50.649926 | debian-bookworm | changed 2026-09-15 03:05:50.658372 | 2026-09-15 03:05:50.658481 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-15 03:05:50.671960 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:05:50.677516 | 2026-09-15 03:05:50.677621 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-15 03:05:51.064179 | debian-bookworm -> localhost | changed 2026-09-15 03:05:51.074929 | 2026-09-15 03:05:51.075030 | TASK [add-build-sshkey : Add back temp key] 2026-09-15 03:05:51.422035 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/3c170a7296fa4892997f9b2e211bb35f_id_rsa (zuul-build-sshkey) 2026-09-15 03:05:51.422328 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018067 2026-09-15 03:05:51.429828 | 2026-09-15 03:05:51.429921 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-15 03:05:51.869315 | debian-bookworm | ok 2026-09-15 03:05:51.876207 | 2026-09-15 03:05:51.876311 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-15 03:05:51.900262 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:05:51.910023 | 2026-09-15 03:05:51.910108 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-15 03:05:52.409149 | debian-bookworm | ok 2026-09-15 03:05:52.421477 | 2026-09-15 03:05:52.421595 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-15 03:05:52.466207 | debian-bookworm | ok 2026-09-15 03:05:52.474382 | 2026-09-15 03:05:52.474522 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-15 03:05:52.742853 | debian-bookworm -> localhost | ok 2026-09-15 03:05:52.749592 | 2026-09-15 03:05:52.749687 | TASK [validate-host : Collect information about the host] 2026-09-15 03:05:53.911551 | debian-bookworm | ok 2026-09-15 03:05:53.921690 | 2026-09-15 03:05:53.921769 | TASK [validate-host : Sanitize hostname] 2026-09-15 03:05:54.045029 | debian-bookworm | ok 2026-09-15 03:05:54.050390 | 2026-09-15 03:05:54.050477 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-15 03:05:54.573613 | debian-bookworm -> localhost | changed 2026-09-15 03:05:54.583777 | 2026-09-15 03:05:54.583924 | TASK [validate-host : Collect information about zuul worker] 2026-09-15 03:05:55.055428 | debian-bookworm | ok 2026-09-15 03:05:55.061997 | 2026-09-15 03:05:55.062111 | TASK [validate-host : Write out all zuul information for each host] 2026-09-15 03:05:55.632959 | debian-bookworm -> localhost | changed 2026-09-15 03:05:55.642359 | 2026-09-15 03:05:55.642448 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-15 03:05:55.991392 | debian-bookworm | ok 2026-09-15 03:05:56.000316 | 2026-09-15 03:05:56.000440 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-15 03:05:56.958165 | debian-bookworm | changed: 2026-09-15 03:05:56.958379 | debian-bookworm | cd+++++++++ src/ 2026-09-15 03:05:56.958414 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-15 03:05:56.958439 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-15 03:05:56.958462 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-09-15 03:05:56.958503 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/logs" 2026-09-15 03:06:52.673983 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/artifacts" 2026-09-15 03:06:53.032616 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3c170a7296fa4892997f9b2e211bb35f/work/docs" 2026-09-15 03:06:53.049079 | 2026-09-15 03:06:53.049171 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-15 03:06:53.723841 | debian-bookworm | changed: 2026-09-15 03:06:53.724020 | debian-bookworm | .d..t...... ./ 2026-09-15 03:06:53.724056 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-15 03:06:53.724090 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-15 03:06:53.724117 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-15 03:06:53.724144 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-15 03:06:53.724165 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-15 03:06:53.724202 | debian-bookworm | changed: All items complete 2026-09-15 03:06:53.724416 | 2026-09-15 03:06:54.286728 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 03:06:54.895628 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 03:06:54.907755 | 2026-09-15 03:06:54.907856 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-15 03:06:54.950697 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:06:54.953391 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:06:54.968188 | 2026-09-15 03:06:54.968258 | PLAY RECAP 2026-09-15 03:06:54.968304 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-15 03:06:54.968419 | 2026-09-15 03:06:55.068332 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-15 03:06:55.069096 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 03:06:55.698599 | 2026-09-15 03:06:55.698704 | PLAY [Base post] 2026-09-15 03:06:55.708591 | 2026-09-15 03:06:55.708687 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-15 03:06:56.346572 | debian-bookworm | changed 2026-09-15 03:06:56.354463 | 2026-09-15 03:06:56.354577 | PLAY RECAP 2026-09-15 03:06:56.354653 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-15 03:06:56.354728 | 2026-09-15 03:06:56.425743 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 03:06:56.427238 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-15 03:06:57.179156 | 2026-09-15 03:06:57.179283 | PLAY [Base post-logs] 2026-09-15 03:06:57.189644 | 2026-09-15 03:06:57.189757 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-15 03:06:57.608523 | localhost | changed 2026-09-15 03:06:57.620668 | 2026-09-15 03:06:57.620794 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-15 03:06:57.647918 | localhost | ok 2026-09-15 03:06:57.650758 | 2026-09-15 03:06:57.650841 | TASK [Set zuul-log-path fact] 2026-09-15 03:06:57.664668 | localhost | ok 2026-09-15 03:06:57.671780 | 2026-09-15 03:06:57.671870 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 03:06:57.695604 | localhost | ok 2026-09-15 03:06:57.698360 | 2026-09-15 03:06:57.698443 | TASK [upload-logs : Create log directories] 2026-09-15 03:06:58.139758 | localhost | changed 2026-09-15 03:06:58.142319 | 2026-09-15 03:06:58.142419 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-15 03:06:58.688495 | localhost -> localhost | ok: Runtime: 0:00:00.010794 2026-09-15 03:06:58.697709 | 2026-09-15 03:06:58.697810 | TASK [upload-logs : Upload logs to log server] 2026-09-15 03:06:59.297640 | localhost | Output suppressed because no_log was given 2026-09-15 03:06:59.299202 | 2026-09-15 03:06:59.299283 | LOOP [upload-logs : Compress console log and json output] 2026-09-15 03:06:59.343562 | localhost | skipping: Conditional result was False 2026-09-15 03:06:59.349253 | localhost | skipping: Conditional result was False 2026-09-15 03:06:59.354899 | 2026-09-15 03:06:59.354991 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-15 03:06:59.403287 | localhost | skipping: Conditional result was False 2026-09-15 03:06:59.403527 | 2026-09-15 03:06:59.408670 | localhost | skipping: Conditional result was False 2026-09-15 03:06:59.420039 | 2026-09-15 03:06:59.420136 | LOOP [upload-logs : Upload console log and json output]