2025-09-16 03:03:30.766732 | Job console starting 2025-09-16 03:03:30.778591 | Updating git repos 2025-09-16 03:03:30.805836 | Cloning repos into workspace 2025-09-16 03:03:30.843691 | Restoring repo states 2025-09-16 03:03:30.858616 | Merging changes 2025-09-16 03:03:30.858639 | Checking out repos 2025-09-16 03:03:30.915139 | Preparing playbooks 2025-09-16 03:03:31.605434 | Running Ansible setup 2025-09-16 03:03:35.800741 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 03:03:36.612031 | 2025-09-16 03:03:36.612188 | PLAY [Base pre] 2025-09-16 03:03:36.628700 | 2025-09-16 03:03:36.628840 | TASK [Setup log path fact] 2025-09-16 03:03:36.661007 | debian-bookworm | ok 2025-09-16 03:03:36.677164 | 2025-09-16 03:03:36.677325 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:03:36.725845 | debian-bookworm | ok 2025-09-16 03:03:36.738507 | 2025-09-16 03:03:36.738648 | TASK [emit-job-header : Print job information] 2025-09-16 03:03:36.778099 | # Job Information 2025-09-16 03:03:36.778271 | Ansible Version: 2.16.14 2025-09-16 03:03:36.778306 | Job: terraform-base-validate-testbed-default 2025-09-16 03:03:36.778338 | Pipeline: periodic-daily 2025-09-16 03:03:36.778377 | Executor: 521e9411259a 2025-09-16 03:03:36.778398 | Triggered by: https://github.com/osism/terraform-base 2025-09-16 03:03:36.778420 | Event ID: e9412de97d7940b2afa1786778713a9e 2025-09-16 03:03:36.783312 | 2025-09-16 03:03:36.783438 | LOOP [emit-job-header : Print node information] 2025-09-16 03:03:36.918389 | debian-bookworm | ok: 2025-09-16 03:03:36.918677 | debian-bookworm | # Node Information 2025-09-16 03:03:36.918738 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 03:03:36.918783 | debian-bookworm | Hostname: debian 2025-09-16 03:03:36.918822 | debian-bookworm | Username: zuul 2025-09-16 03:03:36.918889 | debian-bookworm | Distro: Debian 12.12 2025-09-16 03:03:36.918932 | debian-bookworm | Provider: regiocloud-a 2025-09-16 03:03:36.918968 | debian-bookworm | Region: 2025-09-16 03:03:36.919158 | debian-bookworm | Label: debian-bookworm 2025-09-16 03:03:36.919208 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 03:03:36.919245 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec9:8b4a 2025-09-16 03:03:36.935222 | 2025-09-16 03:03:36.935378 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 03:03:37.455108 | debian-bookworm -> localhost | changed 2025-09-16 03:03:37.462638 | 2025-09-16 03:03:37.462762 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 03:03:38.554194 | debian-bookworm -> localhost | changed 2025-09-16 03:03:38.570066 | 2025-09-16 03:03:38.570207 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 03:03:38.879324 | debian-bookworm -> localhost | ok 2025-09-16 03:03:38.885689 | 2025-09-16 03:03:38.885811 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 03:03:38.914615 | debian-bookworm | ok 2025-09-16 03:03:38.931961 | debian-bookworm | included: /var/lib/zuul/builds/4f3d5c12249d4f558312cc36a561a569/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 03:03:38.938035 | 2025-09-16 03:03:38.938135 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 03:03:40.445940 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 03:03:40.446337 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4f3d5c12249d4f558312cc36a561a569/work/4f3d5c12249d4f558312cc36a561a569_id_rsa 2025-09-16 03:03:40.446467 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4f3d5c12249d4f558312cc36a561a569/work/4f3d5c12249d4f558312cc36a561a569_id_rsa.pub 2025-09-16 03:03:40.446525 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 03:03:40.446577 | debian-bookworm -> localhost | SHA256:lH1q/NmZ84yga8fO7i3NorB+BDAXaRyOM2hYlxRpjCo zuul-build-sshkey 2025-09-16 03:03:40.446651 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 03:03:40.446709 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 03:03:40.446753 | debian-bookworm -> localhost | | .++=o+ | 2025-09-16 03:03:40.446796 | debian-bookworm -> localhost | | o.oBo=o | 2025-09-16 03:03:40.446891 | debian-bookworm -> localhost | | ..o.+=+ . . | 2025-09-16 03:03:40.446948 | debian-bookworm -> localhost | |E .. +.. o | 2025-09-16 03:03:40.446991 | debian-bookworm -> localhost | | . S.+ | 2025-09-16 03:03:40.447048 | debian-bookworm -> localhost | | ... o o | 2025-09-16 03:03:40.447109 | debian-bookworm -> localhost | | .. .+o= | 2025-09-16 03:03:40.447158 | debian-bookworm -> localhost | | ooo=oo= | 2025-09-16 03:03:40.447202 | debian-bookworm -> localhost | | .oo+B=oo o| 2025-09-16 03:03:40.447243 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 03:03:40.447383 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.978518 2025-09-16 03:03:40.460048 | 2025-09-16 03:03:40.460211 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 03:03:40.495006 | debian-bookworm | ok 2025-09-16 03:03:40.510093 | debian-bookworm | included: /var/lib/zuul/builds/4f3d5c12249d4f558312cc36a561a569/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 03:03:40.520567 | 2025-09-16 03:03:40.520666 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 03:03:40.544543 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:03:40.557361 | 2025-09-16 03:03:40.557519 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 03:03:41.222911 | debian-bookworm | changed 2025-09-16 03:03:41.231240 | 2025-09-16 03:03:41.231411 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 03:03:41.473148 | debian-bookworm | ok 2025-09-16 03:03:41.479707 | 2025-09-16 03:03:41.479825 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 03:03:42.106659 | debian-bookworm | changed 2025-09-16 03:03:42.116638 | 2025-09-16 03:03:42.116761 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 03:03:42.749964 | debian-bookworm | changed 2025-09-16 03:03:42.756953 | 2025-09-16 03:03:42.757075 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 03:03:42.781479 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:03:42.791830 | 2025-09-16 03:03:42.791960 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 03:03:43.251710 | debian-bookworm -> localhost | changed 2025-09-16 03:03:43.271923 | 2025-09-16 03:03:43.272068 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 03:03:43.625319 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4f3d5c12249d4f558312cc36a561a569/work/4f3d5c12249d4f558312cc36a561a569_id_rsa (zuul-build-sshkey) 2025-09-16 03:03:43.625888 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018435 2025-09-16 03:03:43.637440 | 2025-09-16 03:03:43.637563 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 03:03:44.047337 | debian-bookworm | ok 2025-09-16 03:03:44.054082 | 2025-09-16 03:03:44.054207 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 03:03:44.088452 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:03:44.110044 | 2025-09-16 03:03:44.110182 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 03:03:44.540907 | debian-bookworm | ok 2025-09-16 03:03:44.556297 | 2025-09-16 03:03:44.556433 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 03:03:44.603657 | debian-bookworm | ok 2025-09-16 03:03:44.611556 | 2025-09-16 03:03:44.611682 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 03:03:44.929801 | debian-bookworm -> localhost | ok 2025-09-16 03:03:44.943384 | 2025-09-16 03:03:44.943545 | TASK [validate-host : Collect information about the host] 2025-09-16 03:03:46.098281 | debian-bookworm | ok 2025-09-16 03:03:46.110595 | 2025-09-16 03:03:46.110716 | TASK [validate-host : Sanitize hostname] 2025-09-16 03:03:46.232434 | debian-bookworm | ok 2025-09-16 03:03:46.288830 | 2025-09-16 03:03:46.288962 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 03:03:46.903236 | debian-bookworm -> localhost | changed 2025-09-16 03:03:46.915114 | 2025-09-16 03:03:46.915253 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 03:03:47.429957 | debian-bookworm | ok 2025-09-16 03:03:47.436409 | 2025-09-16 03:03:47.436547 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 03:03:48.131154 | debian-bookworm -> localhost | changed 2025-09-16 03:03:48.157622 | 2025-09-16 03:03:48.157806 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 03:03:48.426173 | debian-bookworm | ok 2025-09-16 03:03:48.433173 | 2025-09-16 03:03:48.433285 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 03:03:49.399408 | debian-bookworm | changed: 2025-09-16 03:03:49.399663 | debian-bookworm | cd+++++++++ src/ 2025-09-16 03:03:49.399700 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 03:03:49.399725 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 03:03:49.399748 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2025-09-16 03:03:49.399769 | debian-bookworm | localhost | ok: Runtime: 0:00:00.027437 2025-09-16 03:04:11.358507 | 2025-09-16 03:04:11.358591 | TASK [upload-logs : Upload logs to log server] 2025-09-16 03:04:12.894321 | localhost | Output suppressed because no_log was given 2025-09-16 03:04:12.895776 | 2025-09-16 03:04:12.895847 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 03:04:13.002682 | localhost | skipping: Conditional result was False 2025-09-16 03:04:13.029591 | localhost | skipping: Conditional result was False 2025-09-16 03:04:13.041930 | 2025-09-16 03:04:13.042020 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 03:04:13.092766 | localhost | skipping: Conditional result was False 2025-09-16 03:04:13.092965 | 2025-09-16 03:04:13.098175 | localhost | skipping: Conditional result was False 2025-09-16 03:04:13.110241 | 2025-09-16 03:04:13.110325 | LOOP [upload-logs : Upload console log and json output]