2026-09-19 03:19:56.649221 | Job console starting 2026-09-19 03:19:56.664050 | Updating git repos 2026-09-19 03:19:56.690501 | Cloning repos into workspace 2026-09-19 03:19:56.763780 | Restoring repo states 2026-09-19 03:19:56.773294 | Merging changes 2026-09-19 03:19:56.773311 | Checking out repos 2026-09-19 03:19:56.828551 | Preparing playbooks 2026-09-19 03:19:57.768075 | Running Ansible setup 2026-09-19 03:20:02.522972 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-19 03:20:03.322443 | 2026-09-19 03:20:03.322613 | PLAY [Base pre] 2026-09-19 03:20:03.344605 | 2026-09-19 03:20:03.344912 | TASK [Setup log path fact] 2026-09-19 03:20:03.378270 | debian-bookworm | ok 2026-09-19 03:20:03.396108 | 2026-09-19 03:20:03.396291 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-19 03:20:03.447053 | debian-bookworm | ok 2026-09-19 03:20:03.457704 | 2026-09-19 03:20:03.457830 | TASK [emit-job-header : Print job information] 2026-09-19 03:20:03.498895 | # Job Information 2026-09-19 03:20:03.499456 | Ansible Version: 2.16.14 2026-09-19 03:20:03.499532 | Job: terraform-base-validate-testbed-default 2026-09-19 03:20:03.499573 | Pipeline: periodic-daily 2026-09-19 03:20:03.499602 | Executor: 521e9411259a 2026-09-19 03:20:03.499624 | Triggered by: https://github.com/osism/terraform-base 2026-09-19 03:20:03.499646 | Event ID: 85b1ac6a3fca47fba1c96fd08c5ecf63 2026-09-19 03:20:03.506353 | 2026-09-19 03:20:03.506472 | LOOP [emit-job-header : Print node information] 2026-09-19 03:20:03.636008 | debian-bookworm | ok: 2026-09-19 03:20:03.636298 | debian-bookworm | # Node Information 2026-09-19 03:20:03.636337 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-19 03:20:03.636363 | debian-bookworm | Hostname: debian 2026-09-19 03:20:03.636386 | debian-bookworm | Username: zuul 2026-09-19 03:20:03.636407 | debian-bookworm | Distro: Debian 12.15 2026-09-19 03:20:03.636440 | debian-bookworm | Provider: regiocloud-a 2026-09-19 03:20:03.636466 | debian-bookworm | Region: 2026-09-19 03:20:03.636488 | debian-bookworm | Label: debian-bookworm 2026-09-19 03:20:03.636508 | debian-bookworm | Product Name: OpenStack Nova 2026-09-19 03:20:03.636527 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1a:75cf 2026-09-19 03:20:03.653492 | 2026-09-19 03:20:03.653649 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-19 03:20:04.244078 | debian-bookworm -> localhost | changed 2026-09-19 03:20:04.259934 | 2026-09-19 03:20:04.260152 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-19 03:20:05.356638 | debian-bookworm -> localhost | changed 2026-09-19 03:20:05.368196 | 2026-09-19 03:20:05.368318 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-19 03:20:05.659232 | debian-bookworm -> localhost | ok 2026-09-19 03:20:05.665797 | 2026-09-19 03:20:05.665919 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-19 03:20:05.696657 | debian-bookworm | ok 2026-09-19 03:20:05.714033 | debian-bookworm | included: /var/lib/zuul/builds/092fea27449644f78a96900894435964/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-19 03:20:05.722187 | 2026-09-19 03:20:05.722424 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-19 03:20:06.761439 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-19 03:20:06.761956 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/092fea27449644f78a96900894435964/work/092fea27449644f78a96900894435964_id_rsa 2026-09-19 03:20:06.762070 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/092fea27449644f78a96900894435964/work/092fea27449644f78a96900894435964_id_rsa.pub 2026-09-19 03:20:06.762173 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-19 03:20:06.762246 | debian-bookworm -> localhost | SHA256:0cP0TJeMdk0FLCJyWRVlPhPU5GW49pHGPoH+f8+ozH4 zuul-build-sshkey 2026-09-19 03:20:06.762332 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-19 03:20:06.762398 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-19 03:20:06.762458 | debian-bookworm -> localhost | | oo.+BBOB| 2026-09-19 03:20:06.762519 | debian-bookworm -> localhost | | . ++.+++*++| 2026-09-19 03:20:06.762579 | debian-bookworm -> localhost | | o..+ooo*.o| 2026-09-19 03:20:06.762636 | debian-bookworm -> localhost | | . . .oO | 2026-09-19 03:20:06.762691 | debian-bookworm -> localhost | | S ..o.o| 2026-09-19 03:20:06.762755 | debian-bookworm -> localhost | | . o.| 2026-09-19 03:20:06.762814 | debian-bookworm -> localhost | | . .| 2026-09-19 03:20:06.762869 | debian-bookworm -> localhost | | o E+.| 2026-09-19 03:20:06.762926 | debian-bookworm -> localhost | | .=o. B| 2026-09-19 03:20:06.762982 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-19 03:20:06.763162 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.519709 2026-09-19 03:20:06.777267 | 2026-09-19 03:20:06.777417 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-19 03:20:06.813624 | debian-bookworm | ok 2026-09-19 03:20:06.827689 | debian-bookworm | included: /var/lib/zuul/builds/092fea27449644f78a96900894435964/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-19 03:20:06.836391 | 2026-09-19 03:20:06.836491 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-19 03:20:06.870439 | debian-bookworm | skipping: Conditional result was False 2026-09-19 03:20:06.885701 | 2026-09-19 03:20:06.885882 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-19 03:20:07.599865 | debian-bookworm | changed 2026-09-19 03:20:07.606667 | 2026-09-19 03:20:07.606780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-19 03:20:07.886967 | debian-bookworm | ok 2026-09-19 03:20:07.896166 | 2026-09-19 03:20:07.896366 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-19 03:20:08.627905 | debian-bookworm | changed 2026-09-19 03:20:08.637065 | 2026-09-19 03:20:08.637223 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-19 03:20:09.379467 | debian-bookworm | changed 2026-09-19 03:20:09.390161 | 2026-09-19 03:20:09.390286 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-19 03:20:09.415776 | debian-bookworm | skipping: Conditional result was False 2026-09-19 03:20:09.429255 | 2026-09-19 03:20:09.429398 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-19 03:20:09.892190 | debian-bookworm -> localhost | changed 2026-09-19 03:20:09.904711 | 2026-09-19 03:20:09.904833 | TASK [add-build-sshkey : Add back temp key] 2026-09-19 03:20:10.271898 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/092fea27449644f78a96900894435964/work/092fea27449644f78a96900894435964_id_rsa (zuul-build-sshkey) 2026-09-19 03:20:10.272167 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011925 2026-09-19 03:20:10.290943 | 2026-09-19 03:20:10.291071 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-19 03:20:10.765177 | debian-bookworm | ok 2026-09-19 03:20:10.775467 | 2026-09-19 03:20:10.775952 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-19 03:20:10.817798 | debian-bookworm | skipping: Conditional result was False 2026-09-19 03:20:10.832360 | 2026-09-19 03:20:10.832472 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-19 03:20:11.294197 | debian-bookworm | ok 2026-09-19 03:20:11.306319 | 2026-09-19 03:20:11.306433 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-19 03:20:11.339426 | debian-bookworm | ok 2026-09-19 03:20:11.349749 | 2026-09-19 03:20:11.349866 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-19 03:20:11.733265 | debian-bookworm -> localhost | ok 2026-09-19 03:20:11.752255 | 2026-09-19 03:20:11.752463 | TASK [validate-host : Collect information about the host] 2026-09-19 03:20:13.027119 | debian-bookworm | ok 2026-09-19 03:20:13.052629 | 2026-09-19 03:20:13.052763 | TASK [validate-host : Sanitize hostname] 2026-09-19 03:20:13.369283 | debian-bookworm | ok 2026-09-19 03:20:13.374329 | 2026-09-19 03:20:13.374442 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-19 03:20:13.994064 | debian-bookworm -> localhost | changed 2026-09-19 03:20:14.006750 | 2026-09-19 03:20:14.006891 | TASK [validate-host : Collect information about zuul worker] 2026-09-19 03:20:14.447114 | debian-bookworm | ok 2026-09-19 03:20:14.454461 | 2026-09-19 03:20:14.454618 | TASK [validate-host : Write out all zuul information for each host] 2026-09-19 03:20:15.027836 | debian-bookworm -> localhost | changed 2026-09-19 03:20:15.040965 | 2026-09-19 03:20:15.041086 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-19 03:20:15.368691 | debian-bookworm | ok 2026-09-19 03:20:15.376033 | 2026-09-19 03:20:15.376173 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-19 03:20:16.404763 | debian-bookworm | changed: 2026-09-19 03:20:16.405042 | debian-bookworm | cd+++++++++ src/ 2026-09-19 03:20:16.405144 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-19 03:20:16.405188 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-19 03:20:16.405224 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-09-19 03:20:16.405258 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/092fea27449644f78a96900894435964/work/logs" 2026-09-19 03:21:10.876110 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/092fea27449644f78a96900894435964/work/artifacts" 2026-09-19 03:21:11.378585 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/092fea27449644f78a96900894435964/work/docs" 2026-09-19 03:21:11.391426 | 2026-09-19 03:21:11.391603 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-19 03:21:12.589279 | debian-bookworm | changed: 2026-09-19 03:21:12.589464 | debian-bookworm | .d..t...... ./ 2026-09-19 03:21:12.589498 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-19 03:21:12.589522 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-19 03:21:12.589544 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-19 03:21:12.589590 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-19 03:21:12.589611 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-19 03:21:12.589646 | debian-bookworm | changed: All items complete 2026-09-19 03:21:12.589700 | 2026-09-19 03:21:13.221243 | debian-bookworm | changed: .d..t...... ./ 2026-09-19 03:21:13.734047 | debian-bookworm | changed: .d..t...... ./ 2026-09-19 03:21:13.746724 | 2026-09-19 03:21:13.747401 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-19 03:21:13.782805 | debian-bookworm | skipping: Conditional result was False 2026-09-19 03:21:13.788053 | debian-bookworm | skipping: Conditional result was False 2026-09-19 03:21:13.796905 | 2026-09-19 03:21:13.796966 | PLAY RECAP 2026-09-19 03:21:13.797038 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-19 03:21:13.797063 | 2026-09-19 03:21:13.887735 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-19 03:21:13.888432 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-19 03:21:14.586389 | 2026-09-19 03:21:14.586517 | PLAY [Base post] 2026-09-19 03:21:14.599607 | 2026-09-19 03:21:14.599716 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-19 03:21:15.171784 | debian-bookworm | changed 2026-09-19 03:21:15.177789 | 2026-09-19 03:21:15.177867 | PLAY RECAP 2026-09-19 03:21:15.177924 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-19 03:21:15.177984 | 2026-09-19 03:21:15.259036 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-19 03:21:15.261518 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-19 03:21:16.024367 | 2026-09-19 03:21:16.024500 | PLAY [Base post-logs] 2026-09-19 03:21:16.034890 | 2026-09-19 03:21:16.035023 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-19 03:21:16.493804 | localhost | changed 2026-09-19 03:21:16.503465 | 2026-09-19 03:21:16.503591 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-19 03:21:16.528252 | localhost | ok 2026-09-19 03:21:16.531058 | 2026-09-19 03:21:16.531142 | TASK [Set zuul-log-path fact] 2026-09-19 03:21:16.544981 | localhost | ok 2026-09-19 03:21:16.552204 | 2026-09-19 03:21:16.552295 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-19 03:21:16.576217 | localhost | ok 2026-09-19 03:21:16.578877 | 2026-09-19 03:21:16.578961 | TASK [upload-logs : Create log directories] 2026-09-19 03:21:17.220630 | localhost | changed 2026-09-19 03:21:17.223104 | 2026-09-19 03:21:17.223192 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-19 03:21:17.660668 | localhost -> localhost | ok: Runtime: 0:00:00.003003 2026-09-19 03:21:17.664121 | 2026-09-19 03:21:17.664212 | TASK [upload-logs : Upload logs to log server] 2026-09-19 03:21:18.216684 | localhost | Output suppressed because no_log was given 2026-09-19 03:21:18.218574 | 2026-09-19 03:21:18.218791 | LOOP [upload-logs : Compress console log and json output] 2026-09-19 03:21:18.275590 | localhost | skipping: Conditional result was False 2026-09-19 03:21:18.282857 | localhost | skipping: Conditional result was False 2026-09-19 03:21:18.287475 | 2026-09-19 03:21:18.287569 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-19 03:21:18.350071 | localhost | skipping: Conditional result was False 2026-09-19 03:21:18.350322 | 2026-09-19 03:21:18.359980 | localhost | skipping: Conditional result was False 2026-09-19 03:21:18.367695 | 2026-09-19 03:21:18.367916 | LOOP [upload-logs : Upload console log and json output]