2026-05-09 03:18:40.536782 | Job console starting 2026-05-09 03:18:40.547627 | Updating git repos 2026-05-09 03:18:40.601612 | Cloning repos into workspace 2026-05-09 03:18:40.683479 | Restoring repo states 2026-05-09 03:18:40.697515 | Merging changes 2026-05-09 03:18:40.697532 | Checking out repos 2026-05-09 03:18:40.763028 | Preparing playbooks 2026-05-09 03:18:42.191785 | Running Ansible setup 2026-05-09 03:18:48.735263 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 03:18:49.991152 | 2026-05-09 03:18:49.991282 | PLAY [Base pre] 2026-05-09 03:18:50.012678 | 2026-05-09 03:18:50.012805 | TASK [Setup log path fact] 2026-05-09 03:18:50.032031 | debian-bookworm | ok 2026-05-09 03:18:50.050862 | 2026-05-09 03:18:50.051003 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:18:50.100693 | debian-bookworm | ok 2026-05-09 03:18:50.119077 | 2026-05-09 03:18:50.119288 | TASK [emit-job-header : Print job information] 2026-05-09 03:18:50.163907 | # Job Information 2026-05-09 03:18:50.164063 | Ansible Version: 2.16.14 2026-05-09 03:18:50.164099 | Job: ansible-lint 2026-05-09 03:18:50.164132 | Pipeline: periodic-daily 2026-05-09 03:18:50.164155 | Executor: 521e9411259a 2026-05-09 03:18:50.164176 | Triggered by: https://github.com/osism/testbed 2026-05-09 03:18:50.164198 | Event ID: 305b40f1c6f64811b10f45158a002fd0 2026-05-09 03:18:50.168970 | 2026-05-09 03:18:50.169061 | LOOP [emit-job-header : Print node information] 2026-05-09 03:18:50.333574 | debian-bookworm | ok: 2026-05-09 03:18:50.333739 | debian-bookworm | # Node Information 2026-05-09 03:18:50.333773 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-09 03:18:50.333800 | debian-bookworm | Hostname: debian 2026-05-09 03:18:50.333822 | debian-bookworm | Username: zuul 2026-05-09 03:18:50.333843 | debian-bookworm | Distro: Debian 12.13 2026-05-09 03:18:50.333867 | debian-bookworm | Provider: regiocloud-a 2026-05-09 03:18:50.333889 | debian-bookworm | Region: 2026-05-09 03:18:50.333910 | debian-bookworm | Label: debian-bookworm 2026-05-09 03:18:50.333930 | debian-bookworm | Product Name: OpenStack Nova 2026-05-09 03:18:50.333949 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe64:4141 2026-05-09 03:18:50.357334 | 2026-05-09 03:18:50.357521 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 03:18:51.011130 | debian-bookworm -> localhost | changed 2026-05-09 03:18:51.018576 | 2026-05-09 03:18:51.018695 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 03:18:52.383199 | debian-bookworm -> localhost | changed 2026-05-09 03:18:52.405760 | 2026-05-09 03:18:52.405874 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 03:18:53.022265 | debian-bookworm -> localhost | ok 2026-05-09 03:18:53.028474 | 2026-05-09 03:18:53.028576 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 03:18:53.080505 | debian-bookworm | ok 2026-05-09 03:18:53.129233 | debian-bookworm | included: /var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 03:18:53.151925 | 2026-05-09 03:18:53.152047 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 03:18:55.633648 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-09 03:18:55.633824 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/fd268246fbe3486f97cf87f1d2ee46cf_id_rsa 2026-05-09 03:18:55.633855 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/fd268246fbe3486f97cf87f1d2ee46cf_id_rsa.pub 2026-05-09 03:18:55.633877 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-09 03:18:55.633897 | debian-bookworm -> localhost | SHA256:FAVnO2h2fbM2XYo2BTGDOl+om3VxHAa2zMKwD9Opf9U zuul-build-sshkey 2026-05-09 03:18:55.633916 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-09 03:18:55.633943 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-09 03:18:55.633961 | debian-bookworm -> localhost | | +o+.Bo | 2026-05-09 03:18:55.633979 | debian-bookworm -> localhost | | X.B =o | 2026-05-09 03:18:55.633995 | debian-bookworm -> localhost | | O.O.=o+..| 2026-05-09 03:18:55.634012 | debian-bookworm -> localhost | | +o*.oo+o*.| 2026-05-09 03:18:55.634028 | debian-bookworm -> localhost | | S+..+o* E| 2026-05-09 03:18:55.634048 | debian-bookworm -> localhost | | ..o..+ . | 2026-05-09 03:18:55.634064 | debian-bookworm -> localhost | | +... | 2026-05-09 03:18:55.634080 | debian-bookworm -> localhost | | o . | 2026-05-09 03:18:55.634097 | debian-bookworm -> localhost | | | 2026-05-09 03:18:55.634113 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-09 03:18:55.634155 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.138793 2026-05-09 03:18:55.639653 | 2026-05-09 03:18:55.639739 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 03:18:55.668451 | debian-bookworm | ok 2026-05-09 03:18:55.703730 | debian-bookworm | included: /var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 03:18:55.726983 | 2026-05-09 03:18:55.727086 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 03:18:55.771416 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:18:55.781283 | 2026-05-09 03:18:55.781403 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 03:18:56.556094 | debian-bookworm | changed 2026-05-09 03:18:56.564573 | 2026-05-09 03:18:56.564668 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 03:18:56.889549 | debian-bookworm | ok 2026-05-09 03:18:56.895774 | 2026-05-09 03:18:56.895886 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 03:18:57.597405 | debian-bookworm | changed 2026-05-09 03:18:57.605153 | 2026-05-09 03:18:57.605271 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 03:18:58.318988 | debian-bookworm | changed 2026-05-09 03:18:58.324922 | 2026-05-09 03:18:58.325021 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 03:18:58.348793 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:18:58.357136 | 2026-05-09 03:18:58.357232 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 03:18:58.993486 | debian-bookworm -> localhost | changed 2026-05-09 03:18:59.008791 | 2026-05-09 03:18:59.008908 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 03:18:59.421538 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/fd268246fbe3486f97cf87f1d2ee46cf_id_rsa (zuul-build-sshkey) 2026-05-09 03:18:59.421848 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010980 2026-05-09 03:18:59.432412 | 2026-05-09 03:18:59.432516 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 03:18:59.973924 | debian-bookworm | ok 2026-05-09 03:18:59.984171 | 2026-05-09 03:18:59.985537 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 03:19:00.065593 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:19:00.089022 | 2026-05-09 03:19:00.092136 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-09 03:19:00.694412 | debian-bookworm | ok 2026-05-09 03:19:00.729535 | 2026-05-09 03:19:00.729651 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-09 03:19:00.784095 | debian-bookworm | ok 2026-05-09 03:19:00.789138 | 2026-05-09 03:19:00.789223 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-09 03:19:01.159496 | debian-bookworm -> localhost | ok 2026-05-09 03:19:01.167486 | 2026-05-09 03:19:01.167584 | TASK [validate-host : Collect information about the host] 2026-05-09 03:19:02.340705 | debian-bookworm | ok 2026-05-09 03:19:02.375556 | 2026-05-09 03:19:02.375662 | TASK [validate-host : Sanitize hostname] 2026-05-09 03:19:02.710568 | debian-bookworm | ok 2026-05-09 03:19:02.862488 | 2026-05-09 03:19:02.862595 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-09 03:19:03.901042 | debian-bookworm -> localhost | changed 2026-05-09 03:19:03.905574 | 2026-05-09 03:19:03.905655 | TASK [validate-host : Collect information about zuul worker] 2026-05-09 03:19:04.932146 | debian-bookworm | ok 2026-05-09 03:19:04.936013 | 2026-05-09 03:19:04.936095 | TASK [validate-host : Write out all zuul information for each host] 2026-05-09 03:19:06.079249 | debian-bookworm -> localhost | changed 2026-05-09 03:19:06.094373 | 2026-05-09 03:19:06.094465 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-09 03:19:06.409838 | debian-bookworm | ok 2026-05-09 03:19:06.414520 | 2026-05-09 03:19:06.414601 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-09 03:19:07.886114 | debian-bookworm | changed: 2026-05-09 03:19:07.886259 | debian-bookworm | cd+++++++++ src/ 2026-05-09 03:19:07.886286 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-09 03:19:07.886305 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-09 03:19:07.886323 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-09 03:19:07.886339 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/logs" 2026-05-09 03:20:17.561748 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/artifacts" 2026-05-09 03:20:17.900225 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fd268246fbe3486f97cf87f1d2ee46cf/work/docs" 2026-05-09 03:20:17.915932 | 2026-05-09 03:20:17.916163 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 03:20:18.766704 | debian-bookworm | changed: 2026-05-09 03:20:18.769199 | debian-bookworm | .d..t...... ./ 2026-05-09 03:20:18.769326 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-09 03:20:18.769364 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-09 03:20:18.769392 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-09 03:20:18.769445 | debian-bookworm | changed: All items complete 2026-05-09 03:20:18.769473 | 2026-05-09 03:20:19.369474 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:20:19.994185 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:20:20.020784 | 2026-05-09 03:20:20.020939 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 03:20:20.057792 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:20:20.062894 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:20:20.073984 | 2026-05-09 03:20:20.074091 | PLAY RECAP 2026-05-09 03:20:20.074151 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-09 03:20:20.074177 | 2026-05-09 03:20:20.271503 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-09 03:20:20.273425 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:20:21.191761 | 2026-05-09 03:20:21.191949 | PLAY [Base post] 2026-05-09 03:20:21.206450 | 2026-05-09 03:20:21.206603 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 03:20:21.811452 | debian-bookworm | changed 2026-05-09 03:20:21.822013 | 2026-05-09 03:20:21.822159 | PLAY RECAP 2026-05-09 03:20:21.822251 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 03:20:21.822367 | 2026-05-09 03:20:21.967866 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:20:21.968776 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 03:20:22.856632 | 2026-05-09 03:20:22.856817 | PLAY [Base post-logs] 2026-05-09 03:20:22.869600 | 2026-05-09 03:20:22.869761 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 03:20:23.359909 | localhost | changed 2026-05-09 03:20:23.384203 | 2026-05-09 03:20:23.384534 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 03:20:23.425938 | localhost | ok 2026-05-09 03:20:23.431907 | 2026-05-09 03:20:23.432070 | TASK [Set zuul-log-path fact] 2026-05-09 03:20:23.460848 | localhost | ok 2026-05-09 03:20:23.474366 | 2026-05-09 03:20:23.474511 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:20:23.514731 | localhost | ok 2026-05-09 03:20:23.521996 | 2026-05-09 03:20:23.522156 | TASK [upload-logs : Create log directories] 2026-05-09 03:20:24.089536 | localhost | changed 2026-05-09 03:20:24.092621 | 2026-05-09 03:20:24.092732 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 03:20:24.886221 | localhost -> localhost | ok: Runtime: 0:00:00.009294 2026-05-09 03:20:24.890765 | 2026-05-09 03:20:24.890989 | TASK [upload-logs : Upload logs to log server] 2026-05-09 03:20:25.630745 | localhost | Output suppressed because no_log was given 2026-05-09 03:20:25.632745 | 2026-05-09 03:20:25.632857 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 03:20:25.709228 | localhost | skipping: Conditional result was False 2026-05-09 03:20:25.719170 | localhost | skipping: Conditional result was False 2026-05-09 03:20:25.722952 | 2026-05-09 03:20:25.723072 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 03:20:25.803862 | localhost | skipping: Conditional result was False 2026-05-09 03:20:25.804247 | 2026-05-09 03:20:25.812705 | localhost | skipping: Conditional result was False 2026-05-09 03:20:25.821714 | 2026-05-09 03:20:25.821832 | LOOP [upload-logs : Upload console log and json output]