2026-06-09 03:05:20.072481 | Job console starting 2026-06-09 03:05:20.096711 | Updating git repos 2026-06-09 03:05:20.178309 | Cloning repos into workspace 2026-06-09 03:05:20.263570 | Restoring repo states 2026-06-09 03:05:20.323413 | Merging changes 2026-06-09 03:05:20.323433 | Checking out repos 2026-06-09 03:05:20.442827 | Preparing playbooks 2026-06-09 03:05:22.771781 | Running Ansible setup 2026-06-09 03:05:28.993195 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 03:05:30.001113 | 2026-06-09 03:05:30.001310 | PLAY [Base pre] 2026-06-09 03:05:30.037346 | 2026-06-09 03:05:30.037499 | TASK [Setup log path fact] 2026-06-09 03:05:30.061348 | debian-bookworm | ok 2026-06-09 03:05:30.104305 | 2026-06-09 03:05:30.104479 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:05:30.153804 | debian-bookworm | ok 2026-06-09 03:05:30.178244 | 2026-06-09 03:05:30.178368 | TASK [emit-job-header : Print job information] 2026-06-09 03:05:30.240908 | # Job Information 2026-06-09 03:05:30.241066 | Ansible Version: 2.16.14 2026-06-09 03:05:30.241101 | Job: terraform-base-validate-testbed-default 2026-06-09 03:05:30.241134 | Pipeline: periodic-daily 2026-06-09 03:05:30.241156 | Executor: 521e9411259a 2026-06-09 03:05:30.241176 | Triggered by: https://github.com/osism/terraform-base 2026-06-09 03:05:30.241198 | Event ID: efe7f52972ab4dbebf0fc9b3954ebcf9 2026-06-09 03:05:30.250403 | 2026-06-09 03:05:30.250509 | LOOP [emit-job-header : Print node information] 2026-06-09 03:05:30.409011 | debian-bookworm | ok: 2026-06-09 03:05:30.409169 | debian-bookworm | # Node Information 2026-06-09 03:05:30.409200 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-09 03:05:30.409243 | debian-bookworm | Hostname: debian 2026-06-09 03:05:30.409266 | debian-bookworm | Username: zuul 2026-06-09 03:05:30.409284 | debian-bookworm | Distro: Debian 12.14 2026-06-09 03:05:30.409303 | debian-bookworm | Provider: regiocloud-a 2026-06-09 03:05:30.409320 | debian-bookworm | Region: 2026-06-09 03:05:30.409338 | debian-bookworm | Label: debian-bookworm 2026-06-09 03:05:30.409354 | debian-bookworm | Product Name: OpenStack Nova 2026-06-09 03:05:30.409370 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef8:7344 2026-06-09 03:05:30.432739 | 2026-06-09 03:05:30.432864 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-09 03:05:31.094498 | debian-bookworm -> localhost | changed 2026-06-09 03:05:31.102678 | 2026-06-09 03:05:31.102820 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-09 03:05:33.363206 | debian-bookworm -> localhost | changed 2026-06-09 03:05:33.374545 | 2026-06-09 03:05:33.374642 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-09 03:05:34.163174 | debian-bookworm -> localhost | ok 2026-06-09 03:05:34.169087 | 2026-06-09 03:05:34.169335 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-09 03:05:34.211927 | debian-bookworm | ok 2026-06-09 03:05:34.240190 | debian-bookworm | included: /var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-09 03:05:34.252499 | 2026-06-09 03:05:34.252578 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-09 03:05:36.196962 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-09 03:05:36.197214 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/a0d03748690e477cb36b5ae25ad6e568_id_rsa 2026-06-09 03:05:36.197293 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/a0d03748690e477cb36b5ae25ad6e568_id_rsa.pub 2026-06-09 03:05:36.197321 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-09 03:05:36.197345 | debian-bookworm -> localhost | SHA256:PbY04opaHuECag+3SMGqUuYGfu5kUWTBc4vV8osJaOU zuul-build-sshkey 2026-06-09 03:05:36.197380 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-09 03:05:36.197403 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-09 03:05:36.197425 | debian-bookworm -> localhost | | .+. . | 2026-06-09 03:05:36.197446 | debian-bookworm -> localhost | | o+ + . | 2026-06-09 03:05:36.197467 | debian-bookworm -> localhost | | +.= + | 2026-06-09 03:05:36.197491 | debian-bookworm -> localhost | |. o.E . o | 2026-06-09 03:05:36.197527 | debian-bookworm -> localhost | |.o... . S B | 2026-06-09 03:05:36.197567 | debian-bookworm -> localhost | |+.+... + = + | 2026-06-09 03:05:36.197591 | debian-bookworm -> localhost | |+O.++ . . | 2026-06-09 03:05:36.197611 | debian-bookworm -> localhost | |=.X=.o . | 2026-06-09 03:05:36.197633 | debian-bookworm -> localhost | |oo=*o . | 2026-06-09 03:05:36.197654 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-09 03:05:36.197726 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.977342 2026-06-09 03:05:36.205059 | 2026-06-09 03:05:36.205161 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-09 03:05:36.257117 | debian-bookworm | ok 2026-06-09 03:05:36.291528 | debian-bookworm | included: /var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-09 03:05:36.312206 | 2026-06-09 03:05:36.312352 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-09 03:05:36.336162 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:05:36.342401 | 2026-06-09 03:05:36.343155 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-09 03:05:37.224732 | debian-bookworm | changed 2026-06-09 03:05:37.231181 | 2026-06-09 03:05:37.231303 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-09 03:05:37.545442 | debian-bookworm | ok 2026-06-09 03:05:37.557751 | 2026-06-09 03:05:37.557864 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-09 03:05:38.465457 | debian-bookworm | changed 2026-06-09 03:05:38.473512 | 2026-06-09 03:05:38.473604 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-09 03:05:39.217091 | debian-bookworm | changed 2026-06-09 03:05:39.222585 | 2026-06-09 03:05:39.222685 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-09 03:05:39.252259 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:05:39.258365 | 2026-06-09 03:05:39.258467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-09 03:05:39.956093 | debian-bookworm -> localhost | changed 2026-06-09 03:05:39.966735 | 2026-06-09 03:05:39.966865 | TASK [add-build-sshkey : Add back temp key] 2026-06-09 03:05:40.357160 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/a0d03748690e477cb36b5ae25ad6e568_id_rsa (zuul-build-sshkey) 2026-06-09 03:05:40.357385 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014722 2026-06-09 03:05:40.364759 | 2026-06-09 03:05:40.364848 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-09 03:05:40.796051 | debian-bookworm | ok 2026-06-09 03:05:40.803444 | 2026-06-09 03:05:40.803612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-09 03:05:40.829775 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:05:40.849710 | 2026-06-09 03:05:40.849865 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-09 03:05:41.284067 | debian-bookworm | ok 2026-06-09 03:05:41.299981 | 2026-06-09 03:05:41.300183 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-09 03:05:41.329162 | debian-bookworm | ok 2026-06-09 03:05:41.334824 | 2026-06-09 03:05:41.334954 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-09 03:05:41.622504 | debian-bookworm -> localhost | ok 2026-06-09 03:05:41.640754 | 2026-06-09 03:05:41.640950 | TASK [validate-host : Collect information about the host] 2026-06-09 03:05:43.341273 | debian-bookworm | ok 2026-06-09 03:05:43.384192 | 2026-06-09 03:05:43.384368 | TASK [validate-host : Sanitize hostname] 2026-06-09 03:05:43.709442 | debian-bookworm | ok 2026-06-09 03:05:43.832705 | 2026-06-09 03:05:43.832855 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-09 03:05:45.563205 | debian-bookworm -> localhost | changed 2026-06-09 03:05:45.569564 | 2026-06-09 03:05:45.569644 | TASK [validate-host : Collect information about zuul worker] 2026-06-09 03:05:46.082106 | debian-bookworm | ok 2026-06-09 03:05:46.086223 | 2026-06-09 03:05:46.086309 | TASK [validate-host : Write out all zuul information for each host] 2026-06-09 03:05:47.147803 | debian-bookworm -> localhost | changed 2026-06-09 03:05:47.160322 | 2026-06-09 03:05:47.160426 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-09 03:05:47.455897 | debian-bookworm | ok 2026-06-09 03:05:47.460635 | 2026-06-09 03:05:47.460711 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-09 03:05:48.455021 | debian-bookworm | changed: 2026-06-09 03:05:48.455189 | debian-bookworm | cd+++++++++ src/ 2026-06-09 03:05:48.455234 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-09 03:05:48.455259 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-09 03:05:48.455281 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-06-09 03:05:48.455302 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/logs" 2026-06-09 03:06:08.829850 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/artifacts" 2026-06-09 03:06:09.556602 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a0d03748690e477cb36b5ae25ad6e568/work/docs" 2026-06-09 03:06:09.575292 | 2026-06-09 03:06:09.575418 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-09 03:06:11.332741 | debian-bookworm | changed: 2026-06-09 03:06:11.333496 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-09 03:06:11.333538 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-09 03:06:11.333563 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-09 03:06:11.333602 | debian-bookworm | changed: All items complete 2026-06-09 03:06:11.333624 | 2026-06-09 03:06:12.822742 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:06:14.146820 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:06:14.161531 | 2026-06-09 03:06:14.161622 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-09 03:06:14.268939 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:06:14.290086 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:06:14.306294 | 2026-06-09 03:06:14.306459 | PLAY RECAP 2026-06-09 03:06:14.306509 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-09 03:06:14.306530 | 2026-06-09 03:06:14.642238 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-09 03:06:14.643221 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:06:17.084567 | 2026-06-09 03:06:17.084692 | PLAY [Base post] 2026-06-09 03:06:17.110911 | 2026-06-09 03:06:17.111023 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-09 03:06:18.350202 | debian-bookworm | changed 2026-06-09 03:06:18.366746 | 2026-06-09 03:06:18.366857 | PLAY RECAP 2026-06-09 03:06:18.366909 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 03:06:18.366958 | 2026-06-09 03:06:19.119588 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:06:19.120510 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-09 03:06:23.347619 | 2026-06-09 03:06:23.350363 | PLAY [Base post-logs] 2026-06-09 03:06:23.416549 | 2026-06-09 03:06:23.416698 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-09 03:06:24.696265 | localhost | changed 2026-06-09 03:06:24.711952 | 2026-06-09 03:06:24.712102 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-09 03:06:24.897039 | localhost | ok 2026-06-09 03:06:24.900664 | 2026-06-09 03:06:24.900760 | TASK [Set zuul-log-path fact] 2026-06-09 03:06:24.949854 | localhost | ok 2026-06-09 03:06:24.962315 | 2026-06-09 03:06:24.962425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:06:25.092762 | localhost | ok 2026-06-09 03:06:25.099129 | 2026-06-09 03:06:25.099260 | TASK [upload-logs : Create log directories] 2026-06-09 03:06:26.566635 | localhost | changed 2026-06-09 03:06:26.572416 | 2026-06-09 03:06:26.572553 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-09 03:06:27.875667 | localhost -> localhost | ok: Runtime: 0:00:00.013752 2026-06-09 03:06:27.884233 | 2026-06-09 03:06:27.884370 | TASK [upload-logs : Upload logs to log server] 2026-06-09 03:06:29.230477 | localhost | Output suppressed because no_log was given 2026-06-09 03:06:29.232912 | 2026-06-09 03:06:29.233023 | LOOP [upload-logs : Compress console log and json output] 2026-06-09 03:06:29.331816 | localhost | skipping: Conditional result was False 2026-06-09 03:06:29.355550 | localhost | skipping: Conditional result was False 2026-06-09 03:06:29.359979 | 2026-06-09 03:06:29.360091 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-09 03:06:29.504047 | localhost | skipping: Conditional result was False 2026-06-09 03:06:29.504372 | 2026-06-09 03:06:29.526818 | localhost | skipping: Conditional result was False 2026-06-09 03:06:29.540266 | 2026-06-09 03:06:29.540375 | LOOP [upload-logs : Upload console log and json output]