2025-09-12 03:03:26.725883 | Job console starting 2025-09-12 03:03:26.739550 | Updating git repos 2025-09-12 03:03:26.782076 | Cloning repos into workspace 2025-09-12 03:03:26.884190 | Restoring repo states 2025-09-12 03:03:26.891655 | Merging changes 2025-09-12 03:03:26.891670 | Checking out repos 2025-09-12 03:03:26.975695 | Preparing playbooks 2025-09-12 03:03:28.102622 | Running Ansible setup 2025-09-12 03:03:33.813661 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-12 03:03:35.050308 | 2025-09-12 03:03:35.050431 | PLAY [Base pre] 2025-09-12 03:03:35.080390 | 2025-09-12 03:03:35.080515 | TASK [Setup log path fact] 2025-09-12 03:03:35.108368 | debian-bookworm | ok 2025-09-12 03:03:35.125309 | 2025-09-12 03:03:35.125442 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-12 03:03:35.163936 | debian-bookworm | ok 2025-09-12 03:03:35.183067 | 2025-09-12 03:03:35.183184 | TASK [emit-job-header : Print job information] 2025-09-12 03:03:35.231444 | # Job Information 2025-09-12 03:03:35.231596 | Ansible Version: 2.16.14 2025-09-12 03:03:35.231632 | Job: terraform-base-validate-testbed-default 2025-09-12 03:03:35.231666 | Pipeline: periodic-daily 2025-09-12 03:03:35.231690 | Executor: 521e9411259a 2025-09-12 03:03:35.231711 | Triggered by: https://github.com/osism/terraform-base 2025-09-12 03:03:35.231733 | Event ID: fb25099866874664b3d73aa47dffddd7 2025-09-12 03:03:35.236402 | 2025-09-12 03:03:35.236495 | LOOP [emit-job-header : Print node information] 2025-09-12 03:03:35.356367 | debian-bookworm | ok: 2025-09-12 03:03:35.356503 | debian-bookworm | # Node Information 2025-09-12 03:03:35.356531 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-12 03:03:35.356552 | debian-bookworm | Hostname: debian 2025-09-12 03:03:35.356571 | debian-bookworm | Username: zuul 2025-09-12 03:03:35.356588 | debian-bookworm | Distro: Debian 12.12 2025-09-12 03:03:35.356607 | debian-bookworm | Provider: regiocloud-a 2025-09-12 03:03:35.356624 | debian-bookworm | Region: 2025-09-12 03:03:35.356641 | debian-bookworm | Label: debian-bookworm 2025-09-12 03:03:35.356657 | debian-bookworm | Product Name: OpenStack Nova 2025-09-12 03:03:35.356673 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0a:9b3d 2025-09-12 03:03:35.373425 | 2025-09-12 03:03:35.373542 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-12 03:03:36.131618 | debian-bookworm -> localhost | changed 2025-09-12 03:03:36.138388 | 2025-09-12 03:03:36.138495 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-12 03:03:37.468871 | debian-bookworm -> localhost | changed 2025-09-12 03:03:37.479172 | 2025-09-12 03:03:37.479274 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-12 03:03:37.981368 | debian-bookworm -> localhost | ok 2025-09-12 03:03:37.986391 | 2025-09-12 03:03:37.986483 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-12 03:03:38.027072 | debian-bookworm | ok 2025-09-12 03:03:38.056408 | debian-bookworm | included: /var/lib/zuul/builds/49e797d4d46a4f54b170d5357ee18dd3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-12 03:03:38.083469 | 2025-09-12 03:03:38.083578 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-12 03:03:39.665834 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-12 03:03:39.666023 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/49e797d4d46a4f54b170d5357ee18dd3/work/49e797d4d46a4f54b170d5357ee18dd3_id_rsa 2025-09-12 03:03:39.666063 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/49e797d4d46a4f54b170d5357ee18dd3/work/49e797d4d46a4f54b170d5357ee18dd3_id_rsa.pub 2025-09-12 03:03:39.666090 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-12 03:03:39.666114 | debian-bookworm -> localhost | SHA256:K45vXAbz/uE0v25SBfSoWwndJwb9Q0KKUp+z1M0mL38 zuul-build-sshkey 2025-09-12 03:03:39.666146 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-12 03:03:39.666181 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-12 03:03:39.666202 | debian-bookworm -> localhost | | . .+o | 2025-09-12 03:03:39.666223 | debian-bookworm -> localhost | | . o.=*+. | 2025-09-12 03:03:39.666244 | debian-bookworm -> localhost | | . ..*o+B=.| 2025-09-12 03:03:39.666264 | debian-bookworm -> localhost | | o . .ooo=+.| 2025-09-12 03:03:39.666284 | debian-bookworm -> localhost | | +S ..oo ..| 2025-09-12 03:03:39.666309 | debian-bookworm -> localhost | | +. o. o | 2025-09-12 03:03:39.666329 | debian-bookworm -> localhost | | ..+. =. .E| 2025-09-12 03:03:39.666348 | debian-bookworm -> localhost | | oo..o.+. .| 2025-09-12 03:03:39.666368 | debian-bookworm -> localhost | | .oo .o++. | 2025-09-12 03:03:39.666387 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-12 03:03:39.666434 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.827066 2025-09-12 03:03:39.672661 | 2025-09-12 03:03:39.672759 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-12 03:03:39.694029 | debian-bookworm | ok 2025-09-12 03:03:39.709633 | debian-bookworm | included: /var/lib/zuul/builds/49e797d4d46a4f54b170d5357ee18dd3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-12 03:03:39.728485 | 2025-09-12 03:03:39.728574 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-12 03:03:39.751624 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:03:39.757673 | 2025-09-12 03:03:39.757761 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-12 03:03:40.290300 | debian-bookworm | changed 2025-09-12 03:03:40.296613 | 2025-09-12 03:03:40.296703 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-12 03:03:40.563707 | debian-bookworm | ok 2025-09-12 03:03:40.572399 | 2025-09-12 03:03:40.573935 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-12 03:03:41.219257 | debian-bookworm | changed 2025-09-12 03:03:41.228818 | 2025-09-12 03:03:41.228938 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-12 03:03:41.860481 | debian-bookworm | changed 2025-09-12 03:03:41.868912 | 2025-09-12 03:03:41.869010 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-12 03:03:41.912384 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:03:41.918288 | 2025-09-12 03:03:41.918383 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-12 03:03:42.370257 | debian-bookworm -> localhost | changed 2025-09-12 03:03:42.383804 | 2025-09-12 03:03:42.383910 | TASK [add-build-sshkey : Add back temp key] 2025-09-12 03:03:42.877163 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/49e797d4d46a4f54b170d5357ee18dd3/work/49e797d4d46a4f54b170d5357ee18dd3_id_rsa (zuul-build-sshkey) 2025-09-12 03:03:42.877378 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019851 2025-09-12 03:03:42.884801 | 2025-09-12 03:03:42.884889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-12 03:03:43.240179 | debian-bookworm | ok 2025-09-12 03:03:43.245067 | 2025-09-12 03:03:43.245178 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-12 03:03:43.282544 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:03:43.295392 | 2025-09-12 03:03:43.295506 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-12 03:03:43.678761 | debian-bookworm | ok 2025-09-12 03:03:43.695470 | 2025-09-12 03:03:43.695578 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-12 03:03:43.731001 | debian-bookworm | ok 2025-09-12 03:03:43.743342 | 2025-09-12 03:03:43.743443 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-12 03:03:44.050561 | debian-bookworm -> localhost | ok 2025-09-12 03:03:44.061784 | 2025-09-12 03:03:44.061872 | TASK [validate-host : Collect information about the host] 2025-09-12 03:03:45.083195 | debian-bookworm | ok 2025-09-12 03:03:45.092904 | 2025-09-12 03:03:45.092994 | TASK [validate-host : Sanitize hostname] 2025-09-12 03:03:45.177601 | debian-bookworm | ok 2025-09-12 03:03:45.223946 | 2025-09-12 03:03:45.224050 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-12 03:03:45.826703 | debian-bookworm -> localhost | changed 2025-09-12 03:03:45.832527 | 2025-09-12 03:03:45.832619 | TASK [validate-host : Collect information about zuul worker] 2025-09-12 03:03:46.204446 | debian-bookworm | ok 2025-09-12 03:03:46.209142 | 2025-09-12 03:03:46.209263 | TASK [validate-host : Write out all zuul information for each host] 2025-09-12 03:03:47.119897 | debian-bookworm -> localhost | changed 2025-09-12 03:03:47.131571 | 2025-09-12 03:03:47.131700 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-12 03:03:47.380067 | debian-bookworm | ok 2025-09-12 03:03:47.388438 | 2025-09-12 03:03:47.388597 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-12 03:03:48.282011 | debian-bookworm | changed: 2025-09-12 03:03:48.282302 | debian-bookworm | cd+++++++++ src/ 2025-09-12 03:03:48.282343 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-12 03:03:48.282369 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-12 03:03:48.282392 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2025-09-12 03:03:48.282415 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004120 2025-09-12 03:04:04.460903 | 2025-09-12 03:04:04.460991 | TASK [upload-logs : Upload logs to log server] 2025-09-12 03:04:05.228983 | localhost | Output suppressed because no_log was given 2025-09-12 03:04:05.230646 | 2025-09-12 03:04:05.230731 | LOOP [upload-logs : Compress console log and json output] 2025-09-12 03:04:05.298705 | localhost | skipping: Conditional result was False 2025-09-12 03:04:05.304964 | localhost | skipping: Conditional result was False 2025-09-12 03:04:05.317346 | 2025-09-12 03:04:05.317440 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-12 03:04:05.401486 | localhost | skipping: Conditional result was False 2025-09-12 03:04:05.401715 | 2025-09-12 03:04:05.406322 | localhost | skipping: Conditional result was False 2025-09-12 03:04:05.415176 | 2025-09-12 03:04:05.415281 | LOOP [upload-logs : Upload console log and json output]