2026-05-23 03:05:37.667806 | Job console starting 2026-05-23 03:05:37.678116 | Updating git repos 2026-05-23 03:05:37.719530 | Cloning repos into workspace 2026-05-23 03:05:37.827027 | Restoring repo states 2026-05-23 03:05:37.845085 | Merging changes 2026-05-23 03:05:37.845108 | Checking out repos 2026-05-23 03:05:37.920876 | Preparing playbooks 2026-05-23 03:05:39.517249 | Running Ansible setup 2026-05-23 03:05:45.266051 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-23 03:05:46.745087 | 2026-05-23 03:05:46.745300 | PLAY [Base pre] 2026-05-23 03:05:46.784953 | 2026-05-23 03:05:46.785165 | TASK [Setup log path fact] 2026-05-23 03:05:46.843283 | debian-bookworm | ok 2026-05-23 03:05:46.886053 | 2026-05-23 03:05:46.886295 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:05:46.929645 | debian-bookworm | ok 2026-05-23 03:05:46.956318 | 2026-05-23 03:05:46.956564 | TASK [emit-job-header : Print job information] 2026-05-23 03:05:47.033365 | # Job Information 2026-05-23 03:05:47.033676 | Ansible Version: 2.16.14 2026-05-23 03:05:47.033715 | Job: terraform-base-validate-testbed-default 2026-05-23 03:05:47.033751 | Pipeline: periodic-daily 2026-05-23 03:05:47.033815 | Executor: 521e9411259a 2026-05-23 03:05:47.033850 | Triggered by: https://github.com/osism/terraform-base 2026-05-23 03:05:47.033885 | Event ID: c2d37a525077424199ed84e5dcc0295e 2026-05-23 03:05:47.042235 | 2026-05-23 03:05:47.042435 | LOOP [emit-job-header : Print node information] 2026-05-23 03:05:47.407365 | debian-bookworm | ok: 2026-05-23 03:05:47.407619 | debian-bookworm | # Node Information 2026-05-23 03:05:47.407654 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-23 03:05:47.407679 | debian-bookworm | Hostname: debian 2026-05-23 03:05:47.407700 | debian-bookworm | Username: zuul 2026-05-23 03:05:47.407721 | debian-bookworm | Distro: Debian 12.14 2026-05-23 03:05:47.407744 | debian-bookworm | Provider: regiocloud-a 2026-05-23 03:05:47.407766 | debian-bookworm | Region: 2026-05-23 03:05:47.407787 | debian-bookworm | Label: debian-bookworm 2026-05-23 03:05:47.407807 | debian-bookworm | Product Name: OpenStack Nova 2026-05-23 03:05:47.407826 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feba:1e82 2026-05-23 03:05:47.431395 | 2026-05-23 03:05:47.431548 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-23 03:05:48.363540 | debian-bookworm -> localhost | changed 2026-05-23 03:05:48.372216 | 2026-05-23 03:05:48.372346 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-23 03:05:50.446640 | debian-bookworm -> localhost | changed 2026-05-23 03:05:50.457988 | 2026-05-23 03:05:50.458092 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-23 03:05:50.765045 | debian-bookworm -> localhost | ok 2026-05-23 03:05:50.771181 | 2026-05-23 03:05:50.771280 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-23 03:05:50.791364 | debian-bookworm | ok 2026-05-23 03:05:50.805975 | debian-bookworm | included: /var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-23 03:05:50.812218 | 2026-05-23 03:05:50.812297 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-23 03:05:52.666811 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-23 03:05:52.667038 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/b30e4340e9014915ab219e940a807444_id_rsa 2026-05-23 03:05:52.667075 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/b30e4340e9014915ab219e940a807444_id_rsa.pub 2026-05-23 03:05:52.667113 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-23 03:05:52.667138 | debian-bookworm -> localhost | SHA256:gWO085LpM1S8T5+On70LskykmZfZocZfVtaomdprgmU zuul-build-sshkey 2026-05-23 03:05:52.667169 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-23 03:05:52.667191 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-23 03:05:52.667212 | debian-bookworm -> localhost | | . | 2026-05-23 03:05:52.667234 | debian-bookworm -> localhost | | . + | 2026-05-23 03:05:52.667254 | debian-bookworm -> localhost | | * + | 2026-05-23 03:05:52.667274 | debian-bookworm -> localhost | | . B o ..| 2026-05-23 03:05:52.667294 | debian-bookworm -> localhost | | = S o . . +| 2026-05-23 03:05:52.667319 | debian-bookworm -> localhost | | o . OE* * o | 2026-05-23 03:05:52.667340 | debian-bookworm -> localhost | | + ++@ O o | 2026-05-23 03:05:52.667360 | debian-bookworm -> localhost | | o.=.O.* | 2026-05-23 03:05:52.667393 | debian-bookworm -> localhost | | =+B.+o | 2026-05-23 03:05:52.667415 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-23 03:05:52.667468 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.412235 2026-05-23 03:05:52.673764 | 2026-05-23 03:05:52.673853 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-23 03:05:52.701670 | debian-bookworm | ok 2026-05-23 03:05:52.710261 | debian-bookworm | included: /var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-23 03:05:52.719321 | 2026-05-23 03:05:52.719428 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-23 03:05:52.732602 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:05:52.738084 | 2026-05-23 03:05:52.738168 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-23 03:05:53.449152 | debian-bookworm | changed 2026-05-23 03:05:53.462321 | 2026-05-23 03:05:53.462519 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-23 03:05:53.760175 | debian-bookworm | ok 2026-05-23 03:05:53.768082 | 2026-05-23 03:05:53.768212 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-23 03:05:54.411167 | debian-bookworm | changed 2026-05-23 03:05:54.419600 | 2026-05-23 03:05:54.419735 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-23 03:05:55.114002 | debian-bookworm | changed 2026-05-23 03:05:55.120222 | 2026-05-23 03:05:55.120357 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-23 03:05:55.175905 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:05:55.184518 | 2026-05-23 03:05:55.184680 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-23 03:05:56.000148 | debian-bookworm -> localhost | changed 2026-05-23 03:05:56.012569 | 2026-05-23 03:05:56.012726 | TASK [add-build-sshkey : Add back temp key] 2026-05-23 03:05:56.666588 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/b30e4340e9014915ab219e940a807444_id_rsa (zuul-build-sshkey) 2026-05-23 03:05:56.666918 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015861 2026-05-23 03:05:56.676145 | 2026-05-23 03:05:56.676303 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-23 03:05:57.199575 | debian-bookworm | ok 2026-05-23 03:05:57.205036 | 2026-05-23 03:05:57.205147 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-23 03:05:57.229348 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:05:57.241333 | 2026-05-23 03:05:57.241476 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-23 03:05:57.721221 | debian-bookworm | ok 2026-05-23 03:05:57.750199 | 2026-05-23 03:05:57.750355 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-23 03:05:57.800682 | debian-bookworm | ok 2026-05-23 03:05:57.806566 | 2026-05-23 03:05:57.806693 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-23 03:05:58.485944 | debian-bookworm -> localhost | ok 2026-05-23 03:05:58.493266 | 2026-05-23 03:05:58.493405 | TASK [validate-host : Collect information about the host] 2026-05-23 03:05:59.777858 | debian-bookworm | ok 2026-05-23 03:05:59.793017 | 2026-05-23 03:05:59.793179 | TASK [validate-host : Sanitize hostname] 2026-05-23 03:05:59.937600 | debian-bookworm | ok 2026-05-23 03:06:00.001352 | 2026-05-23 03:06:00.001588 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-23 03:06:00.681031 | debian-bookworm -> localhost | changed 2026-05-23 03:06:00.687879 | 2026-05-23 03:06:00.688068 | TASK [validate-host : Collect information about zuul worker] 2026-05-23 03:06:01.117825 | debian-bookworm | ok 2026-05-23 03:06:01.126757 | 2026-05-23 03:06:01.126942 | TASK [validate-host : Write out all zuul information for each host] 2026-05-23 03:06:01.764357 | debian-bookworm -> localhost | changed 2026-05-23 03:06:01.776857 | 2026-05-23 03:06:01.776999 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-23 03:06:02.063511 | debian-bookworm | ok 2026-05-23 03:06:02.078256 | 2026-05-23 03:06:02.078449 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-23 03:06:03.326337 | debian-bookworm | changed: 2026-05-23 03:06:03.326581 | debian-bookworm | cd+++++++++ src/ 2026-05-23 03:06:03.326618 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-23 03:06:03.326642 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-23 03:06:03.326665 | debian-bookworm | cd+++++++++ src/github.com/osism/terraform-base/ 2026-05-23 03:06:03.326687 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/logs" 2026-05-23 03:06:26.577933 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/artifacts" 2026-05-23 03:06:26.847121 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b30e4340e9014915ab219e940a807444/work/docs" 2026-05-23 03:06:26.868840 | 2026-05-23 03:06:26.868983 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-23 03:06:27.848351 | debian-bookworm | changed: 2026-05-23 03:06:27.848623 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-23 03:06:27.848800 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-23 03:06:27.849194 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-23 03:06:27.849281 | debian-bookworm | changed: All items complete 2026-05-23 03:06:27.849319 | 2026-05-23 03:06:28.497730 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:06:29.294955 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:06:29.361599 | 2026-05-23 03:06:29.361799 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-23 03:06:29.425933 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:06:29.437943 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:06:29.455284 | 2026-05-23 03:06:29.455988 | PLAY RECAP 2026-05-23 03:06:29.456112 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-23 03:06:29.456148 | 2026-05-23 03:06:29.766053 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-23 03:06:29.768576 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:06:31.034963 | 2026-05-23 03:06:31.035145 | PLAY [Base post] 2026-05-23 03:06:31.077900 | 2026-05-23 03:06:31.078084 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-23 03:06:31.759620 | debian-bookworm | changed 2026-05-23 03:06:31.767855 | 2026-05-23 03:06:31.767985 | PLAY RECAP 2026-05-23 03:06:31.768059 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-23 03:06:31.768134 | 2026-05-23 03:06:31.910175 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:06:31.913194 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-23 03:06:33.333878 | 2026-05-23 03:06:33.334091 | PLAY [Base post-logs] 2026-05-23 03:06:33.370135 | 2026-05-23 03:06:33.370329 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-23 03:06:34.627497 | localhost | changed 2026-05-23 03:06:34.638404 | 2026-05-23 03:06:34.638617 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-23 03:06:34.703751 | localhost | ok 2026-05-23 03:06:34.707051 | 2026-05-23 03:06:34.707166 | TASK [Set zuul-log-path fact] 2026-05-23 03:06:34.742920 | localhost | ok 2026-05-23 03:06:34.751880 | 2026-05-23 03:06:34.752029 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:06:34.814876 | localhost | ok 2026-05-23 03:06:34.818428 | 2026-05-23 03:06:34.818562 | TASK [upload-logs : Create log directories] 2026-05-23 03:06:35.654405 | localhost | changed 2026-05-23 03:06:35.657575 | 2026-05-23 03:06:35.657689 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-23 03:06:36.585796 | localhost -> localhost | ok: Runtime: 0:00:00.015598 2026-05-23 03:06:36.590318 | 2026-05-23 03:06:36.590508 | TASK [upload-logs : Upload logs to log server] 2026-05-23 03:06:37.629132 | localhost | Output suppressed because no_log was given 2026-05-23 03:06:37.631158 | 2026-05-23 03:06:37.631274 | LOOP [upload-logs : Compress console log and json output] 2026-05-23 03:06:37.739433 | localhost | skipping: Conditional result was False 2026-05-23 03:06:37.760348 | localhost | skipping: Conditional result was False 2026-05-23 03:06:37.763943 | 2026-05-23 03:06:37.764069 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-23 03:06:37.850944 | localhost | skipping: Conditional result was False 2026-05-23 03:06:37.851256 | 2026-05-23 03:06:37.868956 | localhost | skipping: Conditional result was False 2026-05-23 03:06:37.882107 | 2026-05-23 03:06:37.882247 | LOOP [upload-logs : Upload console log and json output]