2026-04-29 08:44:58.973741 | Job console starting 2026-04-29 08:44:58.997934 | Updating git repos 2026-04-29 08:44:59.046708 | Cloning repos into workspace 2026-04-29 08:44:59.126601 | Restoring repo states 2026-04-29 08:44:59.138391 | Merging changes 2026-04-29 08:44:59.687764 | Checking out repos 2026-04-29 08:44:59.742822 | Preparing playbooks 2026-04-29 08:45:00.502383 | Running Ansible setup 2026-04-29 08:45:05.756596 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 08:45:06.604166 | 2026-04-29 08:45:06.604377 | PLAY [Base pre] 2026-04-29 08:45:06.662982 | 2026-04-29 08:45:06.663161 | TASK [Setup log path fact] 2026-04-29 08:45:06.728940 | debian-bookworm | ok 2026-04-29 08:45:06.763426 | 2026-04-29 08:45:06.763609 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 08:45:06.806043 | debian-bookworm | ok 2026-04-29 08:45:06.824600 | 2026-04-29 08:45:06.824748 | TASK [emit-job-header : Print job information] 2026-04-29 08:45:06.881645 | # Job Information 2026-04-29 08:45:06.882393 | Ansible Version: 2.16.14 2026-04-29 08:45:06.882451 | Job: ansible-lint 2026-04-29 08:45:06.882487 | Pipeline: check 2026-04-29 08:45:06.882509 | Executor: 521e9411259a 2026-04-29 08:45:06.882531 | Triggered by: https://github.com/osism/testbed/pull/2881 2026-04-29 08:45:06.882554 | Event ID: aea5fff0-43a7-11f1-9ce6-d4b31e305f3d 2026-04-29 08:45:06.891007 | 2026-04-29 08:45:06.891155 | LOOP [emit-job-header : Print node information] 2026-04-29 08:45:07.048660 | debian-bookworm | ok: 2026-04-29 08:45:07.048960 | debian-bookworm | # Node Information 2026-04-29 08:45:07.048999 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-29 08:45:07.049024 | debian-bookworm | Hostname: debian 2026-04-29 08:45:07.049047 | debian-bookworm | Username: zuul 2026-04-29 08:45:07.049068 | debian-bookworm | Distro: Debian 12.13 2026-04-29 08:45:07.049092 | debian-bookworm | Provider: regiocloud-a 2026-04-29 08:45:07.049113 | debian-bookworm | Region: 2026-04-29 08:45:07.049133 | debian-bookworm | Label: debian-bookworm 2026-04-29 08:45:07.049152 | debian-bookworm | Product Name: OpenStack Nova 2026-04-29 08:45:07.049171 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec6:e4aa 2026-04-29 08:45:07.071007 | 2026-04-29 08:45:07.071147 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 08:45:07.947392 | debian-bookworm -> localhost | changed 2026-04-29 08:45:07.970136 | 2026-04-29 08:45:07.970464 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 08:45:09.663229 | debian-bookworm -> localhost | changed 2026-04-29 08:45:09.674620 | 2026-04-29 08:45:09.674734 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 08:45:10.184228 | debian-bookworm -> localhost | ok 2026-04-29 08:45:10.190573 | 2026-04-29 08:45:10.190668 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 08:45:10.232145 | debian-bookworm | ok 2026-04-29 08:45:10.257789 | debian-bookworm | included: /var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 08:45:10.280026 | 2026-04-29 08:45:10.280151 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 08:45:12.944337 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-29 08:45:12.944621 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/4ed9c29f03574377ba98d65925994aca_id_rsa 2026-04-29 08:45:12.944659 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/4ed9c29f03574377ba98d65925994aca_id_rsa.pub 2026-04-29 08:45:12.944686 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-29 08:45:12.944711 | debian-bookworm -> localhost | SHA256:p2H6QAQy4pzwzMBplReBir68B1UlJH+3DDo7g3tBYaw zuul-build-sshkey 2026-04-29 08:45:12.944735 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-29 08:45:12.944770 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-29 08:45:12.944793 | debian-bookworm -> localhost | |= =o*=+. | 2026-04-29 08:45:12.944815 | debian-bookworm -> localhost | |+X.=oB. | 2026-04-29 08:45:12.944836 | debian-bookworm -> localhost | |o+= =.oo . | 2026-04-29 08:45:12.944856 | debian-bookworm -> localhost | |.. E oo + . | 2026-04-29 08:45:12.944876 | debian-bookworm -> localhost | |. . .o. So. | 2026-04-29 08:45:12.944903 | debian-bookworm -> localhost | | o .ooo + | 2026-04-29 08:45:12.944923 | debian-bookworm -> localhost | |. o. ++ . | 2026-04-29 08:45:12.944942 | debian-bookworm -> localhost | | o ...oo | 2026-04-29 08:45:12.944962 | debian-bookworm -> localhost | | .o.. . | 2026-04-29 08:45:12.944982 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-29 08:45:12.945041 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.691453 2026-04-29 08:45:12.953066 | 2026-04-29 08:45:12.953202 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 08:45:12.982909 | debian-bookworm | ok 2026-04-29 08:45:13.001817 | debian-bookworm | included: /var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 08:45:13.012413 | 2026-04-29 08:45:13.012520 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 08:45:13.037829 | debian-bookworm | skipping: Conditional result was False 2026-04-29 08:45:13.044388 | 2026-04-29 08:45:13.044512 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 08:45:13.792358 | debian-bookworm | changed 2026-04-29 08:45:13.801922 | 2026-04-29 08:45:13.802051 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 08:45:14.068907 | debian-bookworm | ok 2026-04-29 08:45:14.082996 | 2026-04-29 08:45:14.083137 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 08:45:14.925591 | debian-bookworm | changed 2026-04-29 08:45:14.943146 | 2026-04-29 08:45:14.943384 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 08:45:15.629794 | debian-bookworm | changed 2026-04-29 08:45:15.639459 | 2026-04-29 08:45:15.639765 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 08:45:15.667379 | debian-bookworm | skipping: Conditional result was False 2026-04-29 08:45:15.677721 | 2026-04-29 08:45:15.677870 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 08:45:16.428503 | debian-bookworm -> localhost | changed 2026-04-29 08:45:16.441727 | 2026-04-29 08:45:16.441882 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 08:45:17.248681 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/4ed9c29f03574377ba98d65925994aca_id_rsa (zuul-build-sshkey) 2026-04-29 08:45:17.248979 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034144 2026-04-29 08:45:17.258234 | 2026-04-29 08:45:17.258402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 08:45:18.131090 | debian-bookworm | ok 2026-04-29 08:45:18.138762 | 2026-04-29 08:45:18.138934 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 08:45:18.194159 | debian-bookworm | skipping: Conditional result was False 2026-04-29 08:45:18.217423 | 2026-04-29 08:45:18.217581 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-29 08:45:18.908200 | debian-bookworm | ok 2026-04-29 08:45:18.929511 | 2026-04-29 08:45:18.929682 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-29 08:45:18.980790 | debian-bookworm | ok 2026-04-29 08:45:18.986683 | 2026-04-29 08:45:18.986827 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-29 08:45:19.500002 | debian-bookworm -> localhost | ok 2026-04-29 08:45:19.507359 | 2026-04-29 08:45:19.507482 | TASK [validate-host : Collect information about the host] 2026-04-29 08:45:21.102764 | debian-bookworm | ok 2026-04-29 08:45:21.110780 | 2026-04-29 08:45:21.110913 | TASK [validate-host : Sanitize hostname] 2026-04-29 08:45:21.209209 | debian-bookworm | ok 2026-04-29 08:45:21.271674 | 2026-04-29 08:45:21.271830 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-29 08:45:22.007901 | debian-bookworm -> localhost | changed 2026-04-29 08:45:22.014000 | 2026-04-29 08:45:22.014099 | TASK [validate-host : Collect information about zuul worker] 2026-04-29 08:45:22.560437 | debian-bookworm | ok 2026-04-29 08:45:22.564994 | 2026-04-29 08:45:22.565083 | TASK [validate-host : Write out all zuul information for each host] 2026-04-29 08:45:23.275514 | debian-bookworm -> localhost | changed 2026-04-29 08:45:23.283735 | 2026-04-29 08:45:23.283821 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-29 08:45:23.601756 | debian-bookworm | ok 2026-04-29 08:45:23.606295 | 2026-04-29 08:45:23.606379 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-29 08:45:25.073778 | debian-bookworm | changed: 2026-04-29 08:45:25.074017 | debian-bookworm | cd+++++++++ src/ 2026-04-29 08:45:25.074053 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-29 08:45:25.074077 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-29 08:45:25.074098 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-04-29 08:45:25.074119 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/logs" 2026-04-29 08:46:39.649992 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/artifacts" 2026-04-29 08:46:39.915658 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4ed9c29f03574377ba98d65925994aca/work/docs" 2026-04-29 08:46:39.929939 | 2026-04-29 08:46:39.930074 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 08:46:40.748583 | debian-bookworm | changed: 2026-04-29 08:46:40.748880 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-29 08:46:40.748926 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-29 08:46:40.748964 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-29 08:46:40.749021 | debian-bookworm | changed: All items complete 2026-04-29 08:46:40.749073 | 2026-04-29 08:46:41.352743 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 08:46:41.949645 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 08:46:41.977138 | 2026-04-29 08:46:41.977334 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 08:46:42.547488 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010039 2026-04-29 08:46:42.861458 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007039 2026-04-29 08:46:42.873936 | 2026-04-29 08:46:42.874085 | PLAY RECAP 2026-04-29 08:46:42.874144 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-29 08:46:42.874172 | 2026-04-29 08:46:43.026108 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-29 08:46:43.027055 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 08:46:43.859811 | 2026-04-29 08:46:43.860012 | PLAY [Base post] 2026-04-29 08:46:43.875266 | 2026-04-29 08:46:43.875438 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 08:46:44.470770 | debian-bookworm | changed 2026-04-29 08:46:44.488818 | 2026-04-29 08:46:44.488976 | PLAY RECAP 2026-04-29 08:46:44.489045 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 08:46:44.489111 | 2026-04-29 08:46:44.652369 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 08:46:44.653459 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 08:46:45.464836 | 2026-04-29 08:46:45.465032 | PLAY [Base post-logs] 2026-04-29 08:46:45.476453 | 2026-04-29 08:46:45.476599 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 08:46:45.951915 | localhost | changed 2026-04-29 08:46:45.970326 | 2026-04-29 08:46:45.970523 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 08:46:46.020420 | localhost | ok 2026-04-29 08:46:46.026618 | 2026-04-29 08:46:46.026780 | TASK [Set zuul-log-path fact] 2026-04-29 08:46:46.056901 | localhost | ok 2026-04-29 08:46:46.076113 | 2026-04-29 08:46:46.076465 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 08:46:46.118298 | localhost | ok 2026-04-29 08:46:46.125440 | 2026-04-29 08:46:46.125610 | TASK [upload-logs : Create log directories] 2026-04-29 08:46:46.672121 | localhost | changed 2026-04-29 08:46:46.675274 | 2026-04-29 08:46:46.675383 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 08:46:47.213103 | localhost -> localhost | ok: Runtime: 0:00:00.007331 2026-04-29 08:46:47.219691 | 2026-04-29 08:46:47.219855 | TASK [upload-logs : Upload logs to log server] 2026-04-29 08:46:47.826964 | localhost | Output suppressed because no_log was given 2026-04-29 08:46:47.829750 | 2026-04-29 08:46:47.829897 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 08:46:47.892477 | localhost | skipping: Conditional result was False 2026-04-29 08:46:47.896885 | localhost | skipping: Conditional result was False 2026-04-29 08:46:47.912340 | 2026-04-29 08:46:47.912525 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 08:46:47.963606 | localhost | skipping: Conditional result was False 2026-04-29 08:46:47.964342 | 2026-04-29 08:46:47.967466 | localhost | skipping: Conditional result was False 2026-04-29 08:46:47.974111 | 2026-04-29 08:46:47.974349 | LOOP [upload-logs : Upload console log and json output]