2025-10-27 03:09:45.989572 | Job console starting 2025-10-27 03:09:45.997826 | Updating git repos 2025-10-27 03:09:46.018449 | Cloning repos into workspace 2025-10-27 03:09:46.090412 | Restoring repo states 2025-10-27 03:09:46.100545 | Merging changes 2025-10-27 03:09:46.100561 | Checking out repos 2025-10-27 03:09:46.151989 | Preparing playbooks 2025-10-27 03:09:46.840236 | Running Ansible setup 2025-10-27 03:09:51.469360 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-27 03:09:52.448714 | 2025-10-27 03:09:52.448839 | PLAY [Base pre] 2025-10-27 03:09:52.463282 | 2025-10-27 03:09:52.463390 | TASK [Setup log path fact] 2025-10-27 03:09:52.480987 | debian-bookworm | ok 2025-10-27 03:09:52.495157 | 2025-10-27 03:09:52.495264 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-27 03:09:52.523307 | debian-bookworm | ok 2025-10-27 03:09:52.532437 | 2025-10-27 03:09:52.532523 | TASK [emit-job-header : Print job information] 2025-10-27 03:09:52.567309 | # Job Information 2025-10-27 03:09:52.567579 | Ansible Version: 2.16.14 2025-10-27 03:09:52.567702 | Job: terraform-base-validate-testbed-default 2025-10-27 03:09:52.567772 | Pipeline: periodic-daily 2025-10-27 03:09:52.567820 | Executor: 521e9411259a 2025-10-27 03:09:52.567863 | Triggered by: https://github.com/osism/terraform-base 2025-10-27 03:09:52.567908 | Event ID: a4634b8aaf24405ba78a2628f2320d54 2025-10-27 03:09:52.581914 | 2025-10-27 03:09:52.582017 | LOOP [emit-job-header : Print node information] 2025-10-27 03:09:52.696743 | debian-bookworm | ok: 2025-10-27 03:09:52.696901 | debian-bookworm | # Node Information 2025-10-27 03:09:52.696934 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-27 03:09:52.696959 | debian-bookworm | Hostname: debian 2025-10-27 03:09:52.696981 | debian-bookworm | Username: zuul 2025-10-27 03:09:52.697002 | debian-bookworm | Distro: Debian 12.12 2025-10-27 03:09:52.697026 | debian-bookworm | Provider: regiocloud-a 2025-10-27 03:09:52.697048 | debian-bookworm | Region: 2025-10-27 03:09:52.697068 | debian-bookworm | Label: debian-bookworm 2025-10-27 03:09:52.697087 | debian-bookworm | Product Name: OpenStack Nova 2025-10-27 03:09:52.697107 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:41 2025-10-27 03:09:52.709802 | 2025-10-27 03:09:52.709907 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-27 03:09:53.167659 | debian-bookworm -> localhost | changed 2025-10-27 03:09:53.174396 | 2025-10-27 03:09:53.174503 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-27 03:09:54.350271 | debian-bookworm -> localhost | changed 2025-10-27 03:09:54.360900 | 2025-10-27 03:09:54.361042 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-27 03:09:54.711108 | debian-bookworm -> localhost | ok 2025-10-27 03:09:54.718109 | 2025-10-27 03:09:54.718205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-27 03:09:54.751418 | debian-bookworm | ok 2025-10-27 03:09:54.771927 | debian-bookworm | included: /var/lib/zuul/builds/40c2b48752174107894dc616bdd60239/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-27 03:09:54.783155 | 2025-10-27 03:09:54.783275 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-27 03:09:56.054671 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-27 03:09:56.055499 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/40c2b48752174107894dc616bdd60239/work/40c2b48752174107894dc616bdd60239_id_rsa 2025-10-27 03:09:56.055794 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/40c2b48752174107894dc616bdd60239/work/40c2b48752174107894dc616bdd60239_id_rsa.pub 2025-10-27 03:09:56.055831 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-27 03:09:56.055859 | debian-bookworm -> localhost | SHA256:6r3AKRGU4+FXApSXS27NHK9fP1CDnzwlbacvzfRjE/I zuul-build-sshkey 2025-10-27 03:09:56.056252 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-27 03:09:56.057028 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-27 03:09:56.057433 | debian-bookworm -> localhost | | .++ . | 2025-10-27 03:09:56.057476 | debian-bookworm -> localhost | | .= = o | 2025-10-27 03:09:56.057503 | debian-bookworm -> localhost | | o.* B o . . | 2025-10-27 03:09:56.057697 | debian-bookworm -> localhost | | o.= + . . + =| 2025-10-27 03:09:56.057796 | debian-bookworm -> localhost | | .o S. + B.| 2025-10-27 03:09:56.057828 | debian-bookworm -> localhost | | o o. o.*..| 2025-10-27 03:09:56.057883 | debian-bookworm -> localhost | | . = . . oo*o| 2025-10-27 03:09:56.057910 | debian-bookworm -> localhost | | o o . +E=| 2025-10-27 03:09:56.057934 | debian-bookworm -> localhost | | . o. .oo| 2025-10-27 03:09:56.057956 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-27 03:09:56.058014 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.598742 2025-10-27 03:09:56.081556 | 2025-10-27 03:09:56.081671 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-27 03:09:56.110239 | debian-bookworm | ok 2025-10-27 03:09:56.120861 | debian-bookworm | included: /var/lib/zuul/builds/40c2b48752174107894dc616bdd60239/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-27 03:09:56.130071 | 2025-10-27 03:09:56.130156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-27 03:09:56.153334 | debian-bookworm | skipping: Conditional result was False 2025-10-27 03:09:56.159514 | 2025-10-27 03:09:56.159614 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-27 03:09:56.878989 | debian-bookworm | changed 2025-10-27 03:09:56.894259 | 2025-10-27 03:09:56.898130 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-27 03:09:57.215434 | debian-bookworm | ok 2025-10-27 03:09:57.227852 | 2025-10-27 03:09:57.227952 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-27 03:09:57.918136 | debian-bookworm | changed 2025-10-27 03:09:57.928525 | 2025-10-27 03:09:57.928641 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-27 03:09:58.677566 | debian-bookworm | changed 2025-10-27 03:09:58.682788 | 2025-10-27 03:09:58.682922 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-27 03:09:58.736349 | debian-bookworm | skipping: Conditional result was False 2025-10-27 03:09:58.742929 | 2025-10-27 03:09:58.743021 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-27 03:09:59.272042 | debian-bookworm -> localhost | changed 2025-10-27 03:09:59.287664 | 2025-10-27 03:09:59.287763 | TASK [add-build-sshkey : Add back temp key] 2025-10-27 03:09:59.614291 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/40c2b48752174107894dc616bdd60239/work/40c2b48752174107894dc616bdd60239_id_rsa (zuul-build-sshkey) 2025-10-27 03:09:59.614509 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022655 2025-10-27 03:09:59.622035 | 2025-10-27 03:09:59.622127 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-27 03:10:00.062150 | debian-bookworm | ok 2025-10-27 03:10:00.069440 | 2025-10-27 03:10:00.069546 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-27 03:10:00.102665 | debian-bookworm | skipping: Conditional result was False 2025-10-27 03:10:00.112495 | 2025-10-27 03:10:00.112601 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-27 03:10:00.730339 | debian-bookworm | ok 2025-10-27 03:10:00.743583 | 2025-10-27 03:10:00.743681 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-27 03:10:00.790814 | debian-bookworm | ok 2025-10-27 03:10:00.794882 | 2025-10-27 03:10:00.794951 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-27 03:10:01.055237 | debian-bookworm -> localhost | ok 2025-10-27 03:10:01.066336 | 2025-10-27 03:10:01.066417 | TASK [validate-host : Collect information about the host] 2025-10-27 03:10:02.090091 | debian-bookworm | ok 2025-10-27 03:10:02.103968 | 2025-10-27 03:10:02.104069 | TASK [validate-host : Sanitize hostname] 2025-10-27 03:10:02.199636 | debian-bookworm | ok 2025-10-27 03:10:02.227187 | 2025-10-27 03:10:02.227284 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-27 03:10:02.868774 | debian-bookworm -> localhost | changed 2025-10-27 03:10:02.876533 | 2025-10-27 03:10:02.876664 | TASK [validate-host : Collect information about zuul worker] 2025-10-27 03:10:03.335714 | debian-bookworm | ok 2025-10-27 03:10:03.342112 | 2025-10-27 03:10:03.342678 | TASK [validate-host : Write out all zuul information for each host] 2025-10-27 03:10:04.506095 | debian-bookworm -> localhost | changed 2025-10-27 03:10:04.515238 | 2025-10-27 03:10:04.515332 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-27 03:10:04.813399 | debian-bookworm | ok 2025-10-27 03:10:04.819057 | 2025-10-27 03:10:04.819147 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-27 03:10:05.926604 | debian-bookworm | changed: 2025-10-27 03:10:05.926770 | debian-bookworm | cd+++++++++ src/ 2025-10-27 03:10:05.926805 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-27 03:10:05.926969 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-27 03:10:05.927010 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2025-10-27 03:10:05.927033 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003964 2025-10-27 03:10:21.828315 | 2025-10-27 03:10:21.828535 | TASK [upload-logs : Upload logs to log server] 2025-10-27 03:10:22.357630 | localhost | Output suppressed because no_log was given 2025-10-27 03:10:22.359428 | 2025-10-27 03:10:22.359522 | LOOP [upload-logs : Compress console log and json output] 2025-10-27 03:10:22.447998 | localhost | skipping: Conditional result was False 2025-10-27 03:10:22.454209 | localhost | skipping: Conditional result was False 2025-10-27 03:10:22.466670 | 2025-10-27 03:10:22.466842 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-27 03:10:22.506580 | localhost | skipping: Conditional result was False 2025-10-27 03:10:22.506776 | 2025-10-27 03:10:22.511322 | localhost | skipping: Conditional result was False 2025-10-27 03:10:22.525073 | 2025-10-27 03:10:22.525252 | LOOP [upload-logs : Upload console log and json output]