2025-09-06 16:10:34.124635 | Job console starting 2025-09-06 16:10:34.142447 | Updating git repos 2025-09-06 16:10:34.164214 | Cloning repos into workspace 2025-09-06 16:10:34.215121 | Restoring repo states 2025-09-06 16:10:34.228245 | Merging changes 2025-09-06 16:10:34.743753 | Checking out repos 2025-09-06 16:10:34.783793 | Preparing playbooks 2025-09-06 16:10:35.387460 | Running Ansible setup 2025-09-06 16:10:40.433495 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-06 16:10:41.160968 | 2025-09-06 16:10:41.161786 | PLAY [Base pre] 2025-09-06 16:10:41.177993 | 2025-09-06 16:10:41.178121 | TASK [Setup log path fact] 2025-09-06 16:10:41.207136 | debian-bookworm | ok 2025-09-06 16:10:41.222991 | 2025-09-06 16:10:41.223131 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-06 16:10:41.252675 | debian-bookworm | ok 2025-09-06 16:10:41.263400 | 2025-09-06 16:10:41.263548 | TASK [emit-job-header : Print job information] 2025-09-06 16:10:41.313489 | # Job Information 2025-09-06 16:10:41.313729 | Ansible Version: 2.16.14 2025-09-06 16:10:41.313771 | Job: terraform-base-validate-testbed-default 2025-09-06 16:10:41.313813 | Pipeline: check 2025-09-06 16:10:41.313841 | Executor: 521e9411259a 2025-09-06 16:10:41.313867 | Triggered by: https://github.com/osism/terraform-base/pull/88 2025-09-06 16:10:41.313896 | Event ID: 005d2b90-8b3c-11f0-9f6e-045489587fc1 2025-09-06 16:10:41.319283 | 2025-09-06 16:10:41.319397 | LOOP [emit-job-header : Print node information] 2025-09-06 16:10:41.452760 | debian-bookworm | ok: 2025-09-06 16:10:41.452961 | debian-bookworm | # Node Information 2025-09-06 16:10:41.452995 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-06 16:10:41.453021 | debian-bookworm | Hostname: debian 2025-09-06 16:10:41.453043 | debian-bookworm | Username: zuul 2025-09-06 16:10:41.453064 | debian-bookworm | Distro: Debian 12.11 2025-09-06 16:10:41.453089 | debian-bookworm | Provider: regiocloud-a 2025-09-06 16:10:41.453109 | debian-bookworm | Region: 2025-09-06 16:10:41.453131 | debian-bookworm | Label: debian-bookworm 2025-09-06 16:10:41.453150 | debian-bookworm | Product Name: OpenStack Nova 2025-09-06 16:10:41.453169 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7b:2b8a 2025-09-06 16:10:41.465166 | 2025-09-06 16:10:41.465289 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-06 16:10:41.954753 | debian-bookworm -> localhost | changed 2025-09-06 16:10:41.967415 | 2025-09-06 16:10:41.967775 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-06 16:10:43.000988 | debian-bookworm -> localhost | changed 2025-09-06 16:10:43.011927 | 2025-09-06 16:10:43.012045 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-06 16:10:43.278447 | debian-bookworm -> localhost | ok 2025-09-06 16:10:43.288950 | 2025-09-06 16:10:43.289104 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-06 16:10:43.320652 | debian-bookworm | ok 2025-09-06 16:10:43.338461 | debian-bookworm | included: /var/lib/zuul/builds/9fd7edfdd3a947ddac58cf50a8fe8a2d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-06 16:10:43.344702 | 2025-09-06 16:10:43.344811 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-06 16:10:45.132228 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-06 16:10:45.132653 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9fd7edfdd3a947ddac58cf50a8fe8a2d/work/9fd7edfdd3a947ddac58cf50a8fe8a2d_id_rsa 2025-09-06 16:10:45.132740 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9fd7edfdd3a947ddac58cf50a8fe8a2d/work/9fd7edfdd3a947ddac58cf50a8fe8a2d_id_rsa.pub 2025-09-06 16:10:45.132799 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-06 16:10:45.132850 | debian-bookworm -> localhost | SHA256:ATCurGJDOM3105WIPO8vVbC2o7NKxGnnmflQJIfpOyw zuul-build-sshkey 2025-09-06 16:10:45.132911 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-06 16:10:45.132957 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-06 16:10:45.133002 | debian-bookworm -> localhost | | o.. | 2025-09-06 16:10:45.133047 | debian-bookworm -> localhost | | . o o +.. | 2025-09-06 16:10:45.133089 | debian-bookworm -> localhost | | o + * =o | 2025-09-06 16:10:45.133131 | debian-bookworm -> localhost | |.+ o o * *o . | 2025-09-06 16:10:45.133172 | debian-bookworm -> localhost | |o.= B S..o | 2025-09-06 16:10:45.133219 | debian-bookworm -> localhost | |.o o * *+ | 2025-09-06 16:10:45.133263 | debian-bookworm -> localhost | |oo E @o . | 2025-09-06 16:10:45.133304 | debian-bookworm -> localhost | |o . . .+= | 2025-09-06 16:10:45.133347 | debian-bookworm -> localhost | | ...+o | 2025-09-06 16:10:45.133389 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-06 16:10:45.133489 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.316212 2025-09-06 16:10:45.143923 | 2025-09-06 16:10:45.144051 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-06 16:10:45.177004 | debian-bookworm | ok 2025-09-06 16:10:45.189754 | debian-bookworm | included: /var/lib/zuul/builds/9fd7edfdd3a947ddac58cf50a8fe8a2d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-06 16:10:45.199117 | 2025-09-06 16:10:45.199212 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-06 16:10:45.222328 | debian-bookworm | skipping: Conditional result was False 2025-09-06 16:10:45.228481 | 2025-09-06 16:10:45.228595 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-06 16:10:45.939339 | debian-bookworm | changed 2025-09-06 16:10:45.947552 | 2025-09-06 16:10:45.947690 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-06 16:10:46.225679 | debian-bookworm | ok 2025-09-06 16:10:46.233889 | 2025-09-06 16:10:46.234027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-06 16:10:46.906042 | debian-bookworm | changed 2025-09-06 16:10:46.913964 | 2025-09-06 16:10:46.914075 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-06 16:10:47.608638 | debian-bookworm | changed 2025-09-06 16:10:47.614215 | 2025-09-06 16:10:47.614328 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-06 16:10:47.649244 | debian-bookworm | skipping: Conditional result was False 2025-09-06 16:10:47.655365 | 2025-09-06 16:10:47.655470 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-06 16:10:48.114389 | debian-bookworm -> localhost | changed 2025-09-06 16:10:48.129847 | 2025-09-06 16:10:48.129984 | TASK [add-build-sshkey : Add back temp key] 2025-09-06 16:10:48.478539 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9fd7edfdd3a947ddac58cf50a8fe8a2d/work/9fd7edfdd3a947ddac58cf50a8fe8a2d_id_rsa (zuul-build-sshkey) 2025-09-06 16:10:48.479172 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018676 2025-09-06 16:10:48.495032 | 2025-09-06 16:10:48.495169 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-06 16:10:48.908618 | debian-bookworm | ok 2025-09-06 16:10:48.916248 | 2025-09-06 16:10:48.916426 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-06 16:10:48.940566 | debian-bookworm | skipping: Conditional result was False 2025-09-06 16:10:48.952631 | 2025-09-06 16:10:48.952739 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-06 16:10:49.395619 | debian-bookworm | ok 2025-09-06 16:10:49.411032 | 2025-09-06 16:10:49.411147 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-06 16:10:49.453520 | debian-bookworm | ok 2025-09-06 16:10:49.461947 | 2025-09-06 16:10:49.462090 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-06 16:10:49.775556 | debian-bookworm -> localhost | ok 2025-09-06 16:10:49.787538 | 2025-09-06 16:10:49.787709 | TASK [validate-host : Collect information about the host] 2025-09-06 16:10:50.877170 | debian-bookworm | ok 2025-09-06 16:10:50.890853 | 2025-09-06 16:10:50.890972 | TASK [validate-host : Sanitize hostname] 2025-09-06 16:10:51.012380 | debian-bookworm | ok 2025-09-06 16:10:51.057422 | 2025-09-06 16:10:51.057594 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-06 16:10:51.620835 | debian-bookworm -> localhost | changed 2025-09-06 16:10:51.636434 | 2025-09-06 16:10:51.636630 | TASK [validate-host : Collect information about zuul worker] 2025-09-06 16:10:52.077735 | debian-bookworm | ok 2025-09-06 16:10:52.085227 | 2025-09-06 16:10:52.085382 | TASK [validate-host : Write out all zuul information for each host] 2025-09-06 16:10:52.618205 | debian-bookworm -> localhost | changed 2025-09-06 16:10:52.627822 | 2025-09-06 16:10:52.627935 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-06 16:10:52.913164 | debian-bookworm | ok 2025-09-06 16:10:52.921021 | 2025-09-06 16:10:52.921142 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-06 16:10:53.709537 | debian-bookworm | changed: 2025-09-06 16:10:53.709725 | debian-bookworm | cd+++++++++ src/ 2025-09-06 16:10:53.709759 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-06 16:10:53.709782 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-06 16:10:53.709803 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2025-09-06 16:10:53.709823 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006785 2025-09-06 16:11:07.771532 | 2025-09-06 16:11:07.771697 | TASK [upload-logs : Upload logs to log server] 2025-09-06 16:11:08.339427 | localhost | Output suppressed because no_log was given 2025-09-06 16:11:08.343695 | 2025-09-06 16:11:08.343907 | LOOP [upload-logs : Compress console log and json output] 2025-09-06 16:11:08.400557 | localhost | skipping: Conditional result was False 2025-09-06 16:11:08.405621 | localhost | skipping: Conditional result was False 2025-09-06 16:11:08.417029 | 2025-09-06 16:11:08.417249 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-06 16:11:08.462097 | localhost | skipping: Conditional result was False 2025-09-06 16:11:08.462894 | 2025-09-06 16:11:08.466472 | localhost | skipping: Conditional result was False 2025-09-06 16:11:08.480153 | 2025-09-06 16:11:08.480397 | LOOP [upload-logs : Upload console log and json output]