2026-05-07 03:16:17.255363 | Job console starting 2026-05-07 03:16:17.263907 | Updating git repos 2026-05-07 03:16:17.292164 | Cloning repos into workspace 2026-05-07 03:16:17.381597 | Restoring repo states 2026-05-07 03:16:17.400701 | Merging changes 2026-05-07 03:16:17.400718 | Checking out repos 2026-05-07 03:16:17.481730 | Preparing playbooks 2026-05-07 03:16:18.696819 | Running Ansible setup 2026-05-07 03:16:26.466712 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-07 03:16:28.341634 | 2026-05-07 03:16:28.341806 | PLAY [Base pre] 2026-05-07 03:16:28.357755 | 2026-05-07 03:16:28.357871 | TASK [Setup log path fact] 2026-05-07 03:16:28.376120 | debian-bookworm | ok 2026-05-07 03:16:28.394270 | 2026-05-07 03:16:28.394408 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-07 03:16:28.422820 | debian-bookworm | ok 2026-05-07 03:16:28.433506 | 2026-05-07 03:16:28.433615 | TASK [emit-job-header : Print job information] 2026-05-07 03:16:28.472924 | # Job Information 2026-05-07 03:16:28.473088 | Ansible Version: 2.16.14 2026-05-07 03:16:28.473123 | Job: terraform-base-validate-testbed-default 2026-05-07 03:16:28.473155 | Pipeline: periodic-daily 2026-05-07 03:16:28.473178 | Executor: 521e9411259a 2026-05-07 03:16:28.473199 | Triggered by: https://github.com/osism/terraform-base 2026-05-07 03:16:28.473222 | Event ID: 6a9f325e9da44e0390d7b78cdbfa3e04 2026-05-07 03:16:28.478006 | 2026-05-07 03:16:28.478111 | LOOP [emit-job-header : Print node information] 2026-05-07 03:16:28.733400 | debian-bookworm | ok: 2026-05-07 03:16:28.733640 | debian-bookworm | # Node Information 2026-05-07 03:16:28.733706 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-07 03:16:28.733733 | debian-bookworm | Hostname: debian 2026-05-07 03:16:28.733754 | debian-bookworm | Username: zuul 2026-05-07 03:16:28.733775 | debian-bookworm | Distro: Debian 12.13 2026-05-07 03:16:28.733805 | debian-bookworm | Provider: regiocloud-a 2026-05-07 03:16:28.733830 | debian-bookworm | Region: 2026-05-07 03:16:28.733852 | debian-bookworm | Label: debian-bookworm 2026-05-07 03:16:28.733872 | debian-bookworm | Product Name: OpenStack Nova 2026-05-07 03:16:28.733891 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:f3fd 2026-05-07 03:16:28.759819 | 2026-05-07 03:16:28.759942 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-07 03:16:29.811025 | debian-bookworm -> localhost | changed 2026-05-07 03:16:29.817725 | 2026-05-07 03:16:29.817837 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-07 03:16:31.883988 | debian-bookworm -> localhost | changed 2026-05-07 03:16:31.893215 | 2026-05-07 03:16:31.893309 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-07 03:16:32.588473 | debian-bookworm -> localhost | ok 2026-05-07 03:16:32.593432 | 2026-05-07 03:16:32.593528 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-07 03:16:32.644715 | debian-bookworm | ok 2026-05-07 03:16:32.689396 | debian-bookworm | included: /var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-07 03:16:32.738875 | 2026-05-07 03:16:32.739157 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-07 03:16:35.760004 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-07 03:16:35.760213 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/2aa6c1ffe4e2443da02ed1f94f09bf40_id_rsa 2026-05-07 03:16:35.760246 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/2aa6c1ffe4e2443da02ed1f94f09bf40_id_rsa.pub 2026-05-07 03:16:35.760267 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-07 03:16:35.760287 | debian-bookworm -> localhost | SHA256:Kl1GX9JaryN4HzqUmKmD1epTCuiwRvxrDji1BqI2J20 zuul-build-sshkey 2026-05-07 03:16:35.760314 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-07 03:16:35.760333 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-07 03:16:35.760351 | debian-bookworm -> localhost | | | 2026-05-07 03:16:35.760908 | debian-bookworm -> localhost | | . | 2026-05-07 03:16:35.760934 | debian-bookworm -> localhost | | . . + | 2026-05-07 03:16:35.760952 | debian-bookworm -> localhost | | . . = . | 2026-05-07 03:16:35.760970 | debian-bookworm -> localhost | |+ .. .S+o. . | 2026-05-07 03:16:35.760990 | debian-bookworm -> localhost | |==o....+*.o . | 2026-05-07 03:16:35.761007 | debian-bookworm -> localhost | |=O+E.+o=..o + | 2026-05-07 03:16:35.761024 | debian-bookworm -> localhost | |o+Bo..* ..+ o | 2026-05-07 03:16:35.761041 | debian-bookworm -> localhost | |. oo...o ... | 2026-05-07 03:16:35.761058 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-07 03:16:35.761104 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.043463 2026-05-07 03:16:35.766698 | 2026-05-07 03:16:35.766782 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-07 03:16:35.839714 | debian-bookworm | ok 2026-05-07 03:16:35.866109 | debian-bookworm | included: /var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-07 03:16:35.904247 | 2026-05-07 03:16:35.904347 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-07 03:16:35.950531 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:16:35.955674 | 2026-05-07 03:16:35.955764 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-07 03:16:36.976387 | debian-bookworm | changed 2026-05-07 03:16:36.980990 | 2026-05-07 03:16:36.981077 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-07 03:16:37.267029 | debian-bookworm | ok 2026-05-07 03:16:37.272413 | 2026-05-07 03:16:37.272495 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-07 03:16:38.029595 | debian-bookworm | changed 2026-05-07 03:16:38.041712 | 2026-05-07 03:16:38.041809 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-07 03:16:38.828796 | debian-bookworm | changed 2026-05-07 03:16:38.833197 | 2026-05-07 03:16:38.833284 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-07 03:16:38.860082 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:16:38.865898 | 2026-05-07 03:16:38.866007 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-07 03:16:39.717610 | debian-bookworm -> localhost | changed 2026-05-07 03:16:39.728850 | 2026-05-07 03:16:39.728937 | TASK [add-build-sshkey : Add back temp key] 2026-05-07 03:16:40.408329 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/2aa6c1ffe4e2443da02ed1f94f09bf40_id_rsa (zuul-build-sshkey) 2026-05-07 03:16:40.408544 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.073154 2026-05-07 03:16:40.416678 | 2026-05-07 03:16:40.416790 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-07 03:16:40.893326 | debian-bookworm | ok 2026-05-07 03:16:40.897905 | 2026-05-07 03:16:40.897998 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-07 03:16:40.942749 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:16:40.988963 | 2026-05-07 03:16:40.989074 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-07 03:16:41.696035 | debian-bookworm | ok 2026-05-07 03:16:41.722188 | 2026-05-07 03:16:41.722304 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-07 03:16:41.774877 | debian-bookworm | ok 2026-05-07 03:16:41.779908 | 2026-05-07 03:16:41.782966 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-07 03:16:42.608394 | debian-bookworm -> localhost | ok 2026-05-07 03:16:42.614804 | 2026-05-07 03:16:42.614931 | TASK [validate-host : Collect information about the host] 2026-05-07 03:16:44.427893 | debian-bookworm | ok 2026-05-07 03:16:44.444732 | 2026-05-07 03:16:44.444838 | TASK [validate-host : Sanitize hostname] 2026-05-07 03:16:44.564349 | debian-bookworm | ok 2026-05-07 03:16:44.620937 | 2026-05-07 03:16:44.621051 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-07 03:16:45.628144 | debian-bookworm -> localhost | changed 2026-05-07 03:16:45.636760 | 2026-05-07 03:16:45.636858 | TASK [validate-host : Collect information about zuul worker] 2026-05-07 03:16:46.164570 | debian-bookworm | ok 2026-05-07 03:16:46.169438 | 2026-05-07 03:16:46.169529 | TASK [validate-host : Write out all zuul information for each host] 2026-05-07 03:16:46.895305 | debian-bookworm -> localhost | changed 2026-05-07 03:16:46.902960 | 2026-05-07 03:16:46.903048 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-07 03:16:47.193284 | debian-bookworm | ok 2026-05-07 03:16:47.207864 | 2026-05-07 03:16:47.207979 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-07 03:16:48.160376 | debian-bookworm | changed: 2026-05-07 03:16:48.160992 | debian-bookworm | cd+++++++++ src/ 2026-05-07 03:16:48.161040 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-07 03:16:48.161062 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-07 03:16:48.161080 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-05-07 03:16:48.161098 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/logs" 2026-05-07 03:17:05.894584 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/artifacts" 2026-05-07 03:17:06.178898 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2aa6c1ffe4e2443da02ed1f94f09bf40/work/docs" 2026-05-07 03:17:06.192786 | 2026-05-07 03:17:06.192957 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-07 03:17:07.002227 | debian-bookworm | changed: 2026-05-07 03:17:07.002456 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-07 03:17:07.002491 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-07 03:17:07.002525 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-07 03:17:07.002569 | debian-bookworm | changed: All items complete 2026-05-07 03:17:07.002592 | 2026-05-07 03:17:07.580726 | debian-bookworm | changed: .d..t...... ./ 2026-05-07 03:17:08.141961 | debian-bookworm | changed: .d..t...... ./ 2026-05-07 03:17:08.161175 | 2026-05-07 03:17:08.161294 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-07 03:17:08.203971 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:17:08.208468 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:17:08.223626 | 2026-05-07 03:17:08.223711 | PLAY RECAP 2026-05-07 03:17:08.223761 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-07 03:17:08.223786 | 2026-05-07 03:17:08.339765 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-07 03:17:08.342417 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-07 03:17:09.117059 | 2026-05-07 03:17:09.117196 | PLAY [Base post] 2026-05-07 03:17:09.129919 | 2026-05-07 03:17:09.130133 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-07 03:17:09.660459 | debian-bookworm | changed 2026-05-07 03:17:09.670903 | 2026-05-07 03:17:09.671027 | PLAY RECAP 2026-05-07 03:17:09.671088 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-07 03:17:09.671150 | 2026-05-07 03:17:09.804180 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-07 03:17:09.807214 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-07 03:17:10.680897 | 2026-05-07 03:17:10.681065 | PLAY [Base post-logs] 2026-05-07 03:17:10.691424 | 2026-05-07 03:17:10.691547 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-07 03:17:11.425859 | localhost | changed 2026-05-07 03:17:11.454473 | 2026-05-07 03:17:11.454882 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-07 03:17:11.495754 | localhost | ok 2026-05-07 03:17:11.501669 | 2026-05-07 03:17:11.501782 | TASK [Set zuul-log-path fact] 2026-05-07 03:17:11.523116 | localhost | ok 2026-05-07 03:17:11.540835 | 2026-05-07 03:17:11.540953 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-07 03:17:11.576831 | localhost | ok 2026-05-07 03:17:11.582411 | 2026-05-07 03:17:11.582536 | TASK [upload-logs : Create log directories] 2026-05-07 03:17:12.057214 | localhost | changed 2026-05-07 03:17:12.060103 | 2026-05-07 03:17:12.060203 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-07 03:17:12.521165 | localhost -> localhost | ok: Runtime: 0:00:00.004503 2026-05-07 03:17:12.524966 | 2026-05-07 03:17:12.525061 | TASK [upload-logs : Upload logs to log server] 2026-05-07 03:17:13.053255 | localhost | Output suppressed because no_log was given 2026-05-07 03:17:13.055136 | 2026-05-07 03:17:13.055228 | LOOP [upload-logs : Compress console log and json output] 2026-05-07 03:17:13.100238 | localhost | skipping: Conditional result was False 2026-05-07 03:17:13.105810 | localhost | skipping: Conditional result was False 2026-05-07 03:17:13.111153 | 2026-05-07 03:17:13.111251 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-07 03:17:13.159820 | localhost | skipping: Conditional result was False 2026-05-07 03:17:13.160049 | 2026-05-07 03:17:13.164160 | localhost | skipping: Conditional result was False 2026-05-07 03:17:13.167183 | 2026-05-07 03:17:13.167292 | LOOP [upload-logs : Upload console log and json output]