2026-05-29 11:21:46.707889 | Job console starting 2026-05-29 11:21:46.732704 | Updating git repos 2026-05-29 11:21:46.789702 | Cloning repos into workspace 2026-05-29 11:21:46.858418 | Restoring repo states 2026-05-29 11:21:46.865120 | Merging changes 2026-05-29 11:21:47.442198 | Checking out repos 2026-05-29 11:21:47.500802 | Preparing playbooks 2026-05-29 11:21:48.456232 | Running Ansible setup 2026-05-29 11:21:53.057654 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 11:21:53.798655 | 2026-05-29 11:21:53.798815 | PLAY [Base pre] 2026-05-29 11:21:53.837521 | 2026-05-29 11:21:53.837689 | TASK [Setup log path fact] 2026-05-29 11:21:53.859569 | debian-bookworm | ok 2026-05-29 11:21:53.875823 | 2026-05-29 11:21:53.875983 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 11:21:53.935318 | debian-bookworm | ok 2026-05-29 11:21:53.945374 | 2026-05-29 11:21:53.945496 | TASK [emit-job-header : Print job information] 2026-05-29 11:21:53.994829 | # Job Information 2026-05-29 11:21:53.995081 | Ansible Version: 2.16.14 2026-05-29 11:21:53.995118 | Job: flake8 2026-05-29 11:21:53.995153 | Pipeline: check 2026-05-29 11:21:53.995176 | Executor: 521e9411259a 2026-05-29 11:21:53.995198 | Triggered by: https://github.com/osism/testbed/pull/2897 2026-05-29 11:21:53.995236 | Event ID: 8e490f20-5b50-11f1-9c44-3c3078c400af 2026-05-29 11:21:54.001322 | 2026-05-29 11:21:54.001470 | LOOP [emit-job-header : Print node information] 2026-05-29 11:21:54.145149 | debian-bookworm | ok: 2026-05-29 11:21:54.145473 | debian-bookworm | # Node Information 2026-05-29 11:21:54.145515 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 11:21:54.145541 | debian-bookworm | Hostname: debian 2026-05-29 11:21:54.145563 | debian-bookworm | Username: zuul 2026-05-29 11:21:54.145584 | debian-bookworm | Distro: Debian 12.14 2026-05-29 11:21:54.145608 | debian-bookworm | Provider: regiocloud-a 2026-05-29 11:21:54.145629 | debian-bookworm | Region: 2026-05-29 11:21:54.145650 | debian-bookworm | Label: debian-bookworm 2026-05-29 11:21:54.145670 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 11:21:54.145689 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feda:923a 2026-05-29 11:21:54.170145 | 2026-05-29 11:21:54.170316 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 11:21:54.804177 | debian-bookworm -> localhost | changed 2026-05-29 11:21:54.811602 | 2026-05-29 11:21:54.811727 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 11:21:56.007007 | debian-bookworm -> localhost | changed 2026-05-29 11:21:56.019276 | 2026-05-29 11:21:56.019424 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 11:21:56.329459 | debian-bookworm -> localhost | ok 2026-05-29 11:21:56.335960 | 2026-05-29 11:21:56.336098 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 11:21:56.366663 | debian-bookworm | ok 2026-05-29 11:21:56.382044 | debian-bookworm | included: /var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 11:21:56.388619 | 2026-05-29 11:21:56.388735 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 11:21:57.377341 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 11:21:57.377579 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/34455a6410114a14a5906549094c9ee0_id_rsa 2026-05-29 11:21:57.377616 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/34455a6410114a14a5906549094c9ee0_id_rsa.pub 2026-05-29 11:21:57.377643 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 11:21:57.377666 | debian-bookworm -> localhost | SHA256:vyLk0IkE62HDSnnYOPzA31QuMlLbui3fUZTCGpxnWK8 zuul-build-sshkey 2026-05-29 11:21:57.377688 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 11:21:57.377728 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 11:21:57.377750 | debian-bookworm -> localhost | | . | 2026-05-29 11:21:57.377772 | debian-bookworm -> localhost | | ... =.. . | 2026-05-29 11:21:57.377793 | debian-bookworm -> localhost | |o.*oo=o= + | 2026-05-29 11:21:57.377814 | debian-bookworm -> localhost | | @**.+=.+ | 2026-05-29 11:21:57.377834 | debian-bookworm -> localhost | |.+B+*+.ES. | 2026-05-29 11:21:57.377857 | debian-bookworm -> localhost | |. .+o.+ .. | 2026-05-29 11:21:57.377878 | debian-bookworm -> localhost | | o+ . . | 2026-05-29 11:21:57.377898 | debian-bookworm -> localhost | | o .+ o . | 2026-05-29 11:21:57.377919 | debian-bookworm -> localhost | | o. o .. | 2026-05-29 11:21:57.377938 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 11:21:57.377988 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.433115 2026-05-29 11:21:57.385980 | 2026-05-29 11:21:57.386092 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 11:21:57.414933 | debian-bookworm | ok 2026-05-29 11:21:57.425593 | debian-bookworm | included: /var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 11:21:57.434873 | 2026-05-29 11:21:57.434971 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 11:21:57.458466 | debian-bookworm | skipping: Conditional result was False 2026-05-29 11:21:57.464446 | 2026-05-29 11:21:57.464548 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 11:21:58.152511 | debian-bookworm | changed 2026-05-29 11:21:58.158076 | 2026-05-29 11:21:58.158192 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 11:21:58.448421 | debian-bookworm | ok 2026-05-29 11:21:58.454125 | 2026-05-29 11:21:58.454259 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 11:21:59.129335 | debian-bookworm | changed 2026-05-29 11:21:59.139048 | 2026-05-29 11:21:59.139182 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 11:21:59.866730 | debian-bookworm | changed 2026-05-29 11:21:59.879025 | 2026-05-29 11:21:59.879276 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 11:21:59.914503 | debian-bookworm | skipping: Conditional result was False 2026-05-29 11:21:59.927862 | 2026-05-29 11:21:59.928052 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 11:22:00.430901 | debian-bookworm -> localhost | changed 2026-05-29 11:22:00.442665 | 2026-05-29 11:22:00.442792 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 11:22:00.816288 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/34455a6410114a14a5906549094c9ee0_id_rsa (zuul-build-sshkey) 2026-05-29 11:22:00.816553 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011829 2026-05-29 11:22:00.825776 | 2026-05-29 11:22:00.825898 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 11:22:01.241054 | debian-bookworm | ok 2026-05-29 11:22:01.247133 | 2026-05-29 11:22:01.247283 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 11:22:01.271448 | debian-bookworm | skipping: Conditional result was False 2026-05-29 11:22:01.284102 | 2026-05-29 11:22:01.284260 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 11:22:01.759457 | debian-bookworm | ok 2026-05-29 11:22:01.771167 | 2026-05-29 11:22:01.771332 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 11:22:01.799932 | debian-bookworm | ok 2026-05-29 11:22:01.805202 | 2026-05-29 11:22:01.805362 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 11:22:02.123910 | debian-bookworm -> localhost | ok 2026-05-29 11:22:02.131916 | 2026-05-29 11:22:02.132035 | TASK [validate-host : Collect information about the host] 2026-05-29 11:22:03.329914 | debian-bookworm | ok 2026-05-29 11:22:03.340612 | 2026-05-29 11:22:03.340745 | TASK [validate-host : Sanitize hostname] 2026-05-29 11:22:03.453530 | debian-bookworm | ok 2026-05-29 11:22:03.492915 | 2026-05-29 11:22:03.493047 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 11:22:04.098912 | debian-bookworm -> localhost | changed 2026-05-29 11:22:04.112954 | 2026-05-29 11:22:04.113126 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 11:22:04.548348 | debian-bookworm | ok 2026-05-29 11:22:04.553211 | 2026-05-29 11:22:04.553343 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 11:22:05.189507 | debian-bookworm -> localhost | changed 2026-05-29 11:22:05.200757 | 2026-05-29 11:22:05.200876 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 11:22:05.494744 | debian-bookworm | ok 2026-05-29 11:22:05.512857 | 2026-05-29 11:22:05.512988 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 11:22:06.725520 | debian-bookworm | changed: 2026-05-29 11:22:06.725754 | debian-bookworm | cd+++++++++ src/ 2026-05-29 11:22:06.725790 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 11:22:06.725815 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 11:22:06.725837 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-29 11:22:06.725857 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/logs" 2026-05-29 11:22:33.359363 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/artifacts" 2026-05-29 11:22:33.655547 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34455a6410114a14a5906549094c9ee0/work/docs" 2026-05-29 11:22:33.682700 | 2026-05-29 11:22:33.683361 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 11:22:34.584383 | debian-bookworm | changed: 2026-05-29 11:22:34.584667 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 11:22:34.584711 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 11:22:34.584754 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 11:22:34.584811 | debian-bookworm | changed: All items complete 2026-05-29 11:22:34.584842 | 2026-05-29 11:22:35.236101 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 11:22:35.978920 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 11:22:35.998731 | 2026-05-29 11:22:35.998946 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 11:22:36.618620 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011829 2026-05-29 11:22:36.939890 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010897 2026-05-29 11:22:36.971372 | 2026-05-29 11:22:36.971557 | PLAY RECAP 2026-05-29 11:22:36.971657 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-29 11:22:36.971708 | 2026-05-29 11:22:37.147083 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 11:22:37.148227 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 11:22:37.942561 | 2026-05-29 11:22:37.942742 | PLAY [Base post] 2026-05-29 11:22:37.962381 | 2026-05-29 11:22:37.962534 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 11:22:38.768425 | debian-bookworm | changed 2026-05-29 11:22:38.782230 | 2026-05-29 11:22:38.782393 | PLAY RECAP 2026-05-29 11:22:38.782460 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 11:22:38.782520 | 2026-05-29 11:22:39.023996 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 11:22:39.025205 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 11:22:40.604877 | 2026-05-29 11:22:40.605126 | PLAY [Base post-logs] 2026-05-29 11:22:40.627085 | 2026-05-29 11:22:40.627870 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 11:22:41.670352 | localhost | changed 2026-05-29 11:22:41.685238 | 2026-05-29 11:22:41.685450 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 11:22:41.747723 | localhost | ok 2026-05-29 11:22:41.756860 | 2026-05-29 11:22:41.756998 | TASK [Set zuul-log-path fact] 2026-05-29 11:22:41.776382 | localhost | ok 2026-05-29 11:22:41.805315 | 2026-05-29 11:22:41.805473 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 11:22:41.867887 | localhost | ok 2026-05-29 11:22:41.871243 | 2026-05-29 11:22:41.871593 | TASK [upload-logs : Create log directories] 2026-05-29 11:22:43.523816 | localhost | changed 2026-05-29 11:22:43.526376 | 2026-05-29 11:22:43.526463 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 11:22:44.343293 | localhost -> localhost | ok: Runtime: 0:00:00.004132 2026-05-29 11:22:44.347441 | 2026-05-29 11:22:44.347543 | TASK [upload-logs : Upload logs to log server] 2026-05-29 11:22:44.874876 | localhost | Output suppressed because no_log was given 2026-05-29 11:22:44.877848 | 2026-05-29 11:22:44.877952 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 11:22:44.929525 | localhost | skipping: Conditional result was False 2026-05-29 11:22:44.935193 | localhost | skipping: Conditional result was False 2026-05-29 11:22:44.945195 | 2026-05-29 11:22:44.945421 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 11:22:44.989159 | localhost | skipping: Conditional result was False 2026-05-29 11:22:44.989414 | 2026-05-29 11:22:44.993997 | localhost | skipping: Conditional result was False 2026-05-29 11:22:45.002752 | 2026-05-29 11:22:45.002865 | LOOP [upload-logs : Upload console log and json output]