2026-05-16 03:16:45.036065 | Job console starting 2026-05-16 03:16:45.085555 | Updating git repos 2026-05-16 03:16:45.131798 | Cloning repos into workspace 2026-05-16 03:16:45.199222 | Restoring repo states 2026-05-16 03:16:45.210096 | Merging changes 2026-05-16 03:16:45.210116 | Checking out repos 2026-05-16 03:16:45.282338 | Preparing playbooks 2026-05-16 03:16:46.525439 | Running Ansible setup 2026-05-16 03:16:50.839375 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-16 03:16:51.920979 | 2026-05-16 03:16:51.921200 | PLAY [Base pre] 2026-05-16 03:16:51.968182 | 2026-05-16 03:16:51.968358 | TASK [Setup log path fact] 2026-05-16 03:16:52.011322 | debian-bookworm | ok 2026-05-16 03:16:52.035113 | 2026-05-16 03:16:52.035304 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:16:52.075356 | debian-bookworm | ok 2026-05-16 03:16:52.095009 | 2026-05-16 03:16:52.095170 | TASK [emit-job-header : Print job information] 2026-05-16 03:16:52.194330 | # Job Information 2026-05-16 03:16:52.194530 | Ansible Version: 2.16.14 2026-05-16 03:16:52.194565 | Job: terraform-base-validate-testbed-default 2026-05-16 03:16:52.194600 | Pipeline: periodic-daily 2026-05-16 03:16:52.194624 | Executor: 521e9411259a 2026-05-16 03:16:52.194645 | Triggered by: https://github.com/osism/terraform-base 2026-05-16 03:16:52.194667 | Event ID: b016fcbb10fb462d92cd0105624d20e5 2026-05-16 03:16:52.200940 | 2026-05-16 03:16:52.201072 | LOOP [emit-job-header : Print node information] 2026-05-16 03:16:52.420283 | debian-bookworm | ok: 2026-05-16 03:16:52.420566 | debian-bookworm | # Node Information 2026-05-16 03:16:52.420607 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-16 03:16:52.420634 | debian-bookworm | Hostname: debian 2026-05-16 03:16:52.420657 | debian-bookworm | Username: zuul 2026-05-16 03:16:52.420678 | debian-bookworm | Distro: Debian 12.13 2026-05-16 03:16:52.420702 | debian-bookworm | Provider: regiocloud-a 2026-05-16 03:16:52.420723 | debian-bookworm | Region: 2026-05-16 03:16:52.420745 | debian-bookworm | Label: debian-bookworm 2026-05-16 03:16:52.420765 | debian-bookworm | Product Name: OpenStack Nova 2026-05-16 03:16:52.420785 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5e:d522 2026-05-16 03:16:52.436502 | 2026-05-16 03:16:52.436644 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-16 03:16:53.232420 | debian-bookworm -> localhost | changed 2026-05-16 03:16:53.240122 | 2026-05-16 03:16:53.240282 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-16 03:16:54.827515 | debian-bookworm -> localhost | changed 2026-05-16 03:16:54.838943 | 2026-05-16 03:16:54.839077 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-16 03:16:55.236308 | debian-bookworm -> localhost | ok 2026-05-16 03:16:55.242770 | 2026-05-16 03:16:55.242993 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-16 03:16:55.288166 | debian-bookworm | ok 2026-05-16 03:16:55.314623 | debian-bookworm | included: /var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-16 03:16:55.332389 | 2026-05-16 03:16:55.332536 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-16 03:16:57.039748 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-16 03:16:57.039935 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/e17357df1e324c94b7ccc0c37b1aecd9_id_rsa 2026-05-16 03:16:57.039971 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/e17357df1e324c94b7ccc0c37b1aecd9_id_rsa.pub 2026-05-16 03:16:57.039996 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-16 03:16:57.040020 | debian-bookworm -> localhost | SHA256:4wux5M9TFPEtQbpBPF3s/vxnd1MQ/ayBak0oUlSVik0 zuul-build-sshkey 2026-05-16 03:16:57.040052 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-16 03:16:57.040075 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-16 03:16:57.040096 | debian-bookworm -> localhost | | ..o+=++.. | 2026-05-16 03:16:57.040118 | debian-bookworm -> localhost | | ..Eoooo .| 2026-05-16 03:16:57.040152 | debian-bookworm -> localhost | | . +o=oo.o.| 2026-05-16 03:16:57.040172 | debian-bookworm -> localhost | | . o =oo.+ o| 2026-05-16 03:16:57.040192 | debian-bookworm -> localhost | | o.So.+ . + | 2026-05-16 03:16:57.040218 | debian-bookworm -> localhost | | o + .+ . o .| 2026-05-16 03:16:57.040238 | debian-bookworm -> localhost | | + .o o.| 2026-05-16 03:16:57.040258 | debian-bookworm -> localhost | | +.. .B| 2026-05-16 03:16:57.040278 | debian-bookworm -> localhost | | +. .B| 2026-05-16 03:16:57.040297 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-16 03:16:57.040343 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.692419 2026-05-16 03:16:57.046433 | 2026-05-16 03:16:57.046524 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-16 03:16:57.104406 | debian-bookworm | ok 2026-05-16 03:16:57.121170 | debian-bookworm | included: /var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-16 03:16:57.129950 | 2026-05-16 03:16:57.130042 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-16 03:16:57.180018 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:16:57.185665 | 2026-05-16 03:16:57.185756 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-16 03:16:57.812738 | debian-bookworm | changed 2026-05-16 03:16:57.823415 | 2026-05-16 03:16:57.823524 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-16 03:16:58.117268 | debian-bookworm | ok 2026-05-16 03:16:58.129209 | 2026-05-16 03:16:58.129320 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-16 03:16:58.855232 | debian-bookworm | changed 2026-05-16 03:16:58.867960 | 2026-05-16 03:16:58.868068 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-16 03:16:59.614735 | debian-bookworm | changed 2026-05-16 03:16:59.623473 | 2026-05-16 03:16:59.623567 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-16 03:16:59.656760 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:16:59.662933 | 2026-05-16 03:16:59.663033 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-16 03:17:00.447881 | debian-bookworm -> localhost | changed 2026-05-16 03:17:00.458759 | 2026-05-16 03:17:00.458881 | TASK [add-build-sshkey : Add back temp key] 2026-05-16 03:17:01.080004 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/e17357df1e324c94b7ccc0c37b1aecd9_id_rsa (zuul-build-sshkey) 2026-05-16 03:17:01.080240 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036867 2026-05-16 03:17:01.087965 | 2026-05-16 03:17:01.088073 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-16 03:17:01.685980 | debian-bookworm | ok 2026-05-16 03:17:01.692088 | 2026-05-16 03:17:01.692193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-16 03:17:01.735152 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:17:01.745681 | 2026-05-16 03:17:01.745788 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-16 03:17:02.196959 | debian-bookworm | ok 2026-05-16 03:17:02.232040 | 2026-05-16 03:17:02.232173 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-16 03:17:02.270079 | debian-bookworm | ok 2026-05-16 03:17:02.276181 | 2026-05-16 03:17:02.276275 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-16 03:17:02.736926 | debian-bookworm -> localhost | ok 2026-05-16 03:17:02.743830 | 2026-05-16 03:17:02.743926 | TASK [validate-host : Collect information about the host] 2026-05-16 03:17:04.031529 | debian-bookworm | ok 2026-05-16 03:17:04.054569 | 2026-05-16 03:17:04.054680 | TASK [validate-host : Sanitize hostname] 2026-05-16 03:17:04.251642 | debian-bookworm | ok 2026-05-16 03:17:04.356616 | 2026-05-16 03:17:04.356719 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-16 03:17:05.532178 | debian-bookworm -> localhost | changed 2026-05-16 03:17:05.536692 | 2026-05-16 03:17:05.536772 | TASK [validate-host : Collect information about zuul worker] 2026-05-16 03:17:06.111941 | debian-bookworm | ok 2026-05-16 03:17:06.115815 | 2026-05-16 03:17:06.115904 | TASK [validate-host : Write out all zuul information for each host] 2026-05-16 03:17:06.772825 | debian-bookworm -> localhost | changed 2026-05-16 03:17:06.780533 | 2026-05-16 03:17:06.780613 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-16 03:17:07.042884 | debian-bookworm | ok 2026-05-16 03:17:07.047299 | 2026-05-16 03:17:07.047374 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-16 03:17:07.870877 | debian-bookworm | changed: 2026-05-16 03:17:07.871732 | debian-bookworm | cd+++++++++ src/ 2026-05-16 03:17:07.871769 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-16 03:17:07.871790 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-16 03:17:07.871833 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-05-16 03:17:07.872027 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/logs" 2026-05-16 03:17:24.884846 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/artifacts" 2026-05-16 03:17:25.215987 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e17357df1e324c94b7ccc0c37b1aecd9/work/docs" 2026-05-16 03:17:25.239802 | 2026-05-16 03:17:25.239977 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-16 03:17:26.260735 | debian-bookworm | changed: 2026-05-16 03:17:26.260973 | debian-bookworm | .d..t...... ./ 2026-05-16 03:17:26.261007 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-16 03:17:26.261077 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-16 03:17:26.261105 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-16 03:17:26.261148 | debian-bookworm | changed: All items complete 2026-05-16 03:17:26.261174 | 2026-05-16 03:17:26.807555 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:17:27.390741 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:17:27.419913 | 2026-05-16 03:17:27.420221 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-16 03:17:27.452159 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:17:27.459644 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:17:27.473786 | 2026-05-16 03:17:27.473889 | PLAY RECAP 2026-05-16 03:17:27.473940 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-16 03:17:27.473965 | 2026-05-16 03:17:27.629616 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-16 03:17:27.630528 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:17:28.640171 | 2026-05-16 03:17:28.640372 | PLAY [Base post] 2026-05-16 03:17:28.675455 | 2026-05-16 03:17:28.675629 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-16 03:17:29.533467 | debian-bookworm | changed 2026-05-16 03:17:29.545229 | 2026-05-16 03:17:29.545377 | PLAY RECAP 2026-05-16 03:17:29.545446 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-16 03:17:29.545512 | 2026-05-16 03:17:29.907342 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:17:29.908612 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-16 03:17:31.352492 | 2026-05-16 03:17:31.352635 | PLAY [Base post-logs] 2026-05-16 03:17:31.394942 | 2026-05-16 03:17:31.395077 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-16 03:17:31.997365 | localhost | changed 2026-05-16 03:17:32.005517 | 2026-05-16 03:17:32.005638 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-16 03:17:32.044063 | localhost | ok 2026-05-16 03:17:32.046397 | 2026-05-16 03:17:32.046465 | TASK [Set zuul-log-path fact] 2026-05-16 03:17:32.060408 | localhost | ok 2026-05-16 03:17:32.066637 | 2026-05-16 03:17:32.066731 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:17:32.113938 | localhost | ok 2026-05-16 03:17:32.116317 | 2026-05-16 03:17:32.116392 | TASK [upload-logs : Create log directories] 2026-05-16 03:17:32.596154 | localhost | changed 2026-05-16 03:17:32.598648 | 2026-05-16 03:17:32.598731 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-16 03:17:33.480563 | localhost -> localhost | ok: Runtime: 0:00:00.019104 2026-05-16 03:17:33.484416 | 2026-05-16 03:17:33.484499 | TASK [upload-logs : Upload logs to log server] 2026-05-16 03:17:34.341485 | localhost | Output suppressed because no_log was given 2026-05-16 03:17:34.343438 | 2026-05-16 03:17:34.343518 | LOOP [upload-logs : Compress console log and json output] 2026-05-16 03:17:34.425564 | localhost | skipping: Conditional result was False 2026-05-16 03:17:34.439871 | localhost | skipping: Conditional result was False 2026-05-16 03:17:34.449388 | 2026-05-16 03:17:34.449481 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-16 03:17:34.512166 | localhost | skipping: Conditional result was False 2026-05-16 03:17:34.512411 | 2026-05-16 03:17:34.513146 | localhost | skipping: Conditional result was False 2026-05-16 03:17:34.525392 | 2026-05-16 03:17:34.525478 | LOOP [upload-logs : Upload console log and json output]