2025-05-31 19:00:30.653286 | Job console starting 2025-05-31 19:00:30.665487 | Updating git repos 2025-05-31 19:00:30.694505 | Cloning repos into workspace 2025-05-31 19:00:30.749292 | Restoring repo states 2025-05-31 19:00:30.782412 | Merging changes 2025-05-31 19:00:31.308453 | Checking out repos 2025-05-31 19:00:31.358199 | Preparing playbooks 2025-05-31 19:00:32.069925 | Running Ansible setup 2025-05-31 19:00:36.466751 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-31 19:00:37.265484 | 2025-05-31 19:00:37.265681 | PLAY [Base pre] 2025-05-31 19:00:37.282793 | 2025-05-31 19:00:37.282992 | TASK [Setup log path fact] 2025-05-31 19:00:37.308683 | debian-bookworm | ok 2025-05-31 19:00:37.329103 | 2025-05-31 19:00:37.329267 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-31 19:00:37.359992 | debian-bookworm | ok 2025-05-31 19:00:37.369888 | 2025-05-31 19:00:37.370005 | TASK [emit-job-header : Print job information] 2025-05-31 19:00:37.454533 | # Job Information 2025-05-31 19:00:37.455096 | Ansible Version: 2.16.14 2025-05-31 19:00:37.455331 | Job: terraform-base-validate-testbed-default 2025-05-31 19:00:37.455370 | Pipeline: check 2025-05-31 19:00:37.455394 | Executor: 521e9411259a 2025-05-31 19:00:37.455555 | Triggered by: https://github.com/osism/terraform-base/pull/82 2025-05-31 19:00:37.455586 | Event ID: 80daee70-3e51-11f0-843d-431188319325 2025-05-31 19:00:37.468142 | 2025-05-31 19:00:37.468543 | LOOP [emit-job-header : Print node information] 2025-05-31 19:00:37.590541 | debian-bookworm | ok: 2025-05-31 19:00:37.590901 | debian-bookworm | # Node Information 2025-05-31 19:00:37.590943 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-31 19:00:37.590970 | debian-bookworm | Hostname: debian 2025-05-31 19:00:37.590992 | debian-bookworm | Username: zuul 2025-05-31 19:00:37.591013 | debian-bookworm | Distro: Debian 12.11 2025-05-31 19:00:37.591037 | debian-bookworm | Provider: regiocloud-a 2025-05-31 19:00:37.591058 | debian-bookworm | Region: 2025-05-31 19:00:37.591080 | debian-bookworm | Label: debian-bookworm 2025-05-31 19:00:37.591100 | debian-bookworm | Product Name: OpenStack Nova 2025-05-31 19:00:37.591119 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb8:f549 2025-05-31 19:00:37.616242 | 2025-05-31 19:00:37.616673 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-31 19:00:38.283796 | debian-bookworm -> localhost | changed 2025-05-31 19:00:38.293963 | 2025-05-31 19:00:38.294240 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-31 19:00:39.474735 | debian-bookworm -> localhost | changed 2025-05-31 19:00:39.490647 | 2025-05-31 19:00:39.490867 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-31 19:00:39.805489 | debian-bookworm -> localhost | ok 2025-05-31 19:00:39.822162 | 2025-05-31 19:00:39.822341 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-31 19:00:39.864675 | debian-bookworm | ok 2025-05-31 19:00:39.886593 | debian-bookworm | included: /var/lib/zuul/builds/bfd861a30a4f4ad1a7487feb7c514a37/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-31 19:00:39.893829 | 2025-05-31 19:00:39.893965 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-31 19:00:40.660611 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-31 19:00:40.661210 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bfd861a30a4f4ad1a7487feb7c514a37/work/bfd861a30a4f4ad1a7487feb7c514a37_id_rsa 2025-05-31 19:00:40.661336 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bfd861a30a4f4ad1a7487feb7c514a37/work/bfd861a30a4f4ad1a7487feb7c514a37_id_rsa.pub 2025-05-31 19:00:40.661412 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-31 19:00:40.661480 | debian-bookworm -> localhost | SHA256:I0f9t8Fw1XyPpI6xfkrD5VxOSvUx882pwyux6ed4SHc zuul-build-sshkey 2025-05-31 19:00:40.661568 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-31 19:00:40.661633 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-31 19:00:40.661693 | debian-bookworm -> localhost | | .o| 2025-05-31 19:00:40.661755 | debian-bookworm -> localhost | | . ..+| 2025-05-31 19:00:40.661893 | debian-bookworm -> localhost | | . . .oo=o| 2025-05-31 19:00:40.661954 | debian-bookworm -> localhost | | . ...=.oO| 2025-05-31 19:00:40.662012 | debian-bookworm -> localhost | | . S =+ *.=| 2025-05-31 19:00:40.662087 | debian-bookworm -> localhost | | o ooBoB.E | 2025-05-31 19:00:40.662145 | debian-bookworm -> localhost | | .= X++ | 2025-05-31 19:00:40.662222 | debian-bookworm -> localhost | | ..*ooo | 2025-05-31 19:00:40.662285 | debian-bookworm -> localhost | | o==o | 2025-05-31 19:00:40.662355 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-31 19:00:40.662499 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.266687 2025-05-31 19:00:40.677721 | 2025-05-31 19:00:40.677937 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-31 19:00:40.723390 | debian-bookworm | ok 2025-05-31 19:00:40.734863 | debian-bookworm | included: /var/lib/zuul/builds/bfd861a30a4f4ad1a7487feb7c514a37/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-31 19:00:40.744759 | 2025-05-31 19:00:40.744902 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-31 19:00:40.769280 | debian-bookworm | skipping: Conditional result was False 2025-05-31 19:00:40.776327 | 2025-05-31 19:00:40.776439 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-31 19:00:41.465758 | debian-bookworm | changed 2025-05-31 19:00:41.474918 | 2025-05-31 19:00:41.475054 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-31 19:00:41.760132 | debian-bookworm | ok 2025-05-31 19:00:41.769905 | 2025-05-31 19:00:41.770066 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-31 19:00:42.432450 | debian-bookworm | changed 2025-05-31 19:00:42.440187 | 2025-05-31 19:00:42.440323 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-31 19:00:43.124445 | debian-bookworm | changed 2025-05-31 19:00:43.131047 | 2025-05-31 19:00:43.131174 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-31 19:00:43.155385 | debian-bookworm | skipping: Conditional result was False 2025-05-31 19:00:43.170382 | 2025-05-31 19:00:43.170577 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-31 19:00:43.727030 | debian-bookworm -> localhost | changed 2025-05-31 19:00:43.738728 | 2025-05-31 19:00:43.738989 | TASK [add-build-sshkey : Add back temp key] 2025-05-31 19:00:44.136333 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bfd861a30a4f4ad1a7487feb7c514a37/work/bfd861a30a4f4ad1a7487feb7c514a37_id_rsa (zuul-build-sshkey) 2025-05-31 19:00:44.137071 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017707 2025-05-31 19:00:44.154125 | 2025-05-31 19:00:44.154298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-31 19:00:44.593403 | debian-bookworm | ok 2025-05-31 19:00:44.601360 | 2025-05-31 19:00:44.601510 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-31 19:00:44.636662 | debian-bookworm | skipping: Conditional result was False 2025-05-31 19:00:44.658706 | 2025-05-31 19:00:44.658911 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-31 19:00:45.130995 | debian-bookworm | ok 2025-05-31 19:00:45.145255 | 2025-05-31 19:00:45.145390 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-31 19:00:45.189551 | debian-bookworm | ok 2025-05-31 19:00:45.196929 | 2025-05-31 19:00:45.197086 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-31 19:00:45.508814 | debian-bookworm -> localhost | ok 2025-05-31 19:00:45.522522 | 2025-05-31 19:00:45.522680 | TASK [validate-host : Collect information about the host] 2025-05-31 19:00:46.679004 | debian-bookworm | ok 2025-05-31 19:00:46.691964 | 2025-05-31 19:00:46.692094 | TASK [validate-host : Sanitize hostname] 2025-05-31 19:00:46.811238 | debian-bookworm | ok 2025-05-31 19:00:46.860474 | 2025-05-31 19:00:46.860636 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-31 19:00:47.506823 | debian-bookworm -> localhost | changed 2025-05-31 19:00:47.520479 | 2025-05-31 19:00:47.520754 | TASK [validate-host : Collect information about zuul worker] 2025-05-31 19:00:47.949446 | debian-bookworm | ok 2025-05-31 19:00:47.954562 | 2025-05-31 19:00:47.954704 | TASK [validate-host : Write out all zuul information for each host] 2025-05-31 19:00:48.557532 | debian-bookworm -> localhost | changed 2025-05-31 19:00:48.577674 | 2025-05-31 19:00:48.577933 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-31 19:00:48.857241 | debian-bookworm | ok 2025-05-31 19:00:48.866711 | 2025-05-31 19:00:48.866942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-31 19:00:49.678966 | debian-bookworm | changed: 2025-05-31 19:00:49.679244 | debian-bookworm | cd+++++++++ src/ 2025-05-31 19:00:49.679283 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-31 19:00:49.679311 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-31 19:00:49.679337 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2025-05-31 19:00:49.679360 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008060 2025-05-31 19:01:04.727747 | 2025-05-31 19:01:04.728004 | TASK [upload-logs : Upload logs to log server] 2025-05-31 19:01:05.328284 | localhost | Output suppressed because no_log was given 2025-05-31 19:01:05.332837 | 2025-05-31 19:01:05.333042 | LOOP [upload-logs : Compress console log and json output] 2025-05-31 19:01:05.392097 | localhost | skipping: Conditional result was False 2025-05-31 19:01:05.397162 | localhost | skipping: Conditional result was False 2025-05-31 19:01:05.405353 | 2025-05-31 19:01:05.405625 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-31 19:01:05.456227 | localhost | skipping: Conditional result was False 2025-05-31 19:01:05.456891 | 2025-05-31 19:01:05.460091 | localhost | skipping: Conditional result was False 2025-05-31 19:01:05.468039 | 2025-05-31 19:01:05.468309 | LOOP [upload-logs : Upload console log and json output]