2026-08-22 03:08:57.408476 | Job console starting 2026-08-22 03:08:57.434975 | Updating git repos 2026-08-22 03:08:57.499773 | Cloning repos into workspace 2026-08-22 03:08:57.643833 | Restoring repo states 2026-08-22 03:08:57.660020 | Merging changes 2026-08-22 03:08:57.660041 | Checking out repos 2026-08-22 03:08:57.790563 | Preparing playbooks 2026-08-22 03:08:59.768358 | Running Ansible setup 2026-08-22 03:09:07.204231 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 03:09:08.695767 | 2026-08-22 03:09:08.695927 | PLAY [Base pre] 2026-08-22 03:09:08.733321 | 2026-08-22 03:09:08.733452 | TASK [Setup log path fact] 2026-08-22 03:09:08.771828 | debian-bookworm | ok 2026-08-22 03:09:08.804161 | 2026-08-22 03:09:08.804298 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 03:09:08.843148 | debian-bookworm | ok 2026-08-22 03:09:08.864977 | 2026-08-22 03:09:08.865136 | TASK [emit-job-header : Print job information] 2026-08-22 03:09:08.946784 | # Job Information 2026-08-22 03:09:08.947023 | Ansible Version: 2.16.14 2026-08-22 03:09:08.947057 | Job: python-black 2026-08-22 03:09:08.947084 | Pipeline: periodic-daily 2026-08-22 03:09:08.947104 | Executor: 521e9411259a 2026-08-22 03:09:08.947121 | Triggered by: https://github.com/osism/testbed 2026-08-22 03:09:08.947139 | Event ID: 4e47b6261bd3437a8370e8049c59bf70 2026-08-22 03:09:08.953611 | 2026-08-22 03:09:08.954005 | LOOP [emit-job-header : Print node information] 2026-08-22 03:09:09.092554 | debian-bookworm | ok: 2026-08-22 03:09:09.092715 | debian-bookworm | # Node Information 2026-08-22 03:09:09.092755 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-22 03:09:09.092777 | debian-bookworm | Hostname: debian 2026-08-22 03:09:09.092796 | debian-bookworm | Username: zuul 2026-08-22 03:09:09.092814 | debian-bookworm | Distro: Debian 12.15 2026-08-22 03:09:09.092833 | debian-bookworm | Provider: regiocloud-a 2026-08-22 03:09:09.092851 | debian-bookworm | Region: 2026-08-22 03:09:09.092869 | debian-bookworm | Label: debian-bookworm 2026-08-22 03:09:09.092885 | debian-bookworm | Product Name: OpenStack Nova 2026-08-22 03:09:09.092902 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:2128 2026-08-22 03:09:09.108987 | 2026-08-22 03:09:09.109103 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-22 03:09:10.488086 | debian-bookworm -> localhost | changed 2026-08-22 03:09:10.494217 | 2026-08-22 03:09:10.494308 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-22 03:09:11.678793 | debian-bookworm -> localhost | changed 2026-08-22 03:09:11.692625 | 2026-08-22 03:09:11.692747 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-22 03:09:11.928584 | debian-bookworm -> localhost | ok 2026-08-22 03:09:11.935556 | 2026-08-22 03:09:11.935661 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-22 03:09:11.953836 | debian-bookworm | ok 2026-08-22 03:09:11.966366 | debian-bookworm | included: /var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-22 03:09:11.978307 | 2026-08-22 03:09:11.978404 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-22 03:09:13.539410 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-22 03:09:13.539654 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/bebd529ed3cf464285831cf22fd296f4_id_rsa 2026-08-22 03:09:13.539695 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/bebd529ed3cf464285831cf22fd296f4_id_rsa.pub 2026-08-22 03:09:13.539748 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-22 03:09:13.539775 | debian-bookworm -> localhost | SHA256:nGQ4IAdGqV5kq0yW0PdZH41/k5Dl67G1f9Ff15vJW5U zuul-build-sshkey 2026-08-22 03:09:13.539797 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-22 03:09:13.539830 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-22 03:09:13.539852 | debian-bookworm -> localhost | | o=oo o o. | 2026-08-22 03:09:13.539873 | debian-bookworm -> localhost | |..o=.. .. o +. | 2026-08-22 03:09:13.539894 | debian-bookworm -> localhost | |..+...ooo. o ... | 2026-08-22 03:09:13.539915 | debian-bookworm -> localhost | |.+ o o= .. . +..| 2026-08-22 03:09:13.539936 | debian-bookworm -> localhost | |= o S .oE=| 2026-08-22 03:09:13.539958 | debian-bookworm -> localhost | | + . =B| 2026-08-22 03:09:13.539979 | debian-bookworm -> localhost | | +.X| 2026-08-22 03:09:13.539998 | debian-bookworm -> localhost | | ==| 2026-08-22 03:09:13.540019 | debian-bookworm -> localhost | | .+| 2026-08-22 03:09:13.540039 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-22 03:09:13.540118 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.778900 2026-08-22 03:09:13.546494 | 2026-08-22 03:09:13.546604 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-22 03:09:13.580865 | debian-bookworm | ok 2026-08-22 03:09:13.600282 | debian-bookworm | included: /var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-22 03:09:13.625449 | 2026-08-22 03:09:13.625563 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-22 03:09:13.639096 | debian-bookworm | skipping: Conditional result was False 2026-08-22 03:09:13.644695 | 2026-08-22 03:09:13.644801 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-22 03:09:14.287933 | debian-bookworm | changed 2026-08-22 03:09:14.294478 | 2026-08-22 03:09:14.294588 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-22 03:09:14.545538 | debian-bookworm | ok 2026-08-22 03:09:14.551199 | 2026-08-22 03:09:14.551302 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-22 03:09:15.271929 | debian-bookworm | changed 2026-08-22 03:09:15.282103 | 2026-08-22 03:09:15.282221 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-22 03:09:15.979533 | debian-bookworm | changed 2026-08-22 03:09:15.993029 | 2026-08-22 03:09:15.993135 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-22 03:09:16.019995 | debian-bookworm | skipping: Conditional result was False 2026-08-22 03:09:16.026819 | 2026-08-22 03:09:16.026962 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-22 03:09:16.684587 | debian-bookworm -> localhost | changed 2026-08-22 03:09:16.700338 | 2026-08-22 03:09:16.700464 | TASK [add-build-sshkey : Add back temp key] 2026-08-22 03:09:17.708561 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/bebd529ed3cf464285831cf22fd296f4_id_rsa (zuul-build-sshkey) 2026-08-22 03:09:17.709067 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033589 2026-08-22 03:09:17.732352 | 2026-08-22 03:09:17.732524 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-22 03:09:18.548408 | debian-bookworm | ok 2026-08-22 03:09:18.554794 | 2026-08-22 03:09:18.572001 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-22 03:09:18.640753 | debian-bookworm | skipping: Conditional result was False 2026-08-22 03:09:18.664153 | 2026-08-22 03:09:18.664340 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-22 03:09:19.416697 | debian-bookworm | ok 2026-08-22 03:09:19.468098 | 2026-08-22 03:09:19.468286 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-22 03:09:19.567077 | debian-bookworm | ok 2026-08-22 03:09:19.618459 | 2026-08-22 03:09:19.619262 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-22 03:09:20.692237 | debian-bookworm -> localhost | ok 2026-08-22 03:09:20.702767 | 2026-08-22 03:09:20.703010 | TASK [validate-host : Collect information about the host] 2026-08-22 03:09:22.214688 | debian-bookworm | ok 2026-08-22 03:09:22.240827 | 2026-08-22 03:09:22.240945 | TASK [validate-host : Sanitize hostname] 2026-08-22 03:09:22.552955 | debian-bookworm | ok 2026-08-22 03:09:22.564360 | 2026-08-22 03:09:22.564484 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-22 03:09:23.294917 | debian-bookworm -> localhost | changed 2026-08-22 03:09:23.299888 | 2026-08-22 03:09:23.299993 | TASK [validate-host : Collect information about zuul worker] 2026-08-22 03:09:24.013827 | debian-bookworm | ok 2026-08-22 03:09:24.017950 | 2026-08-22 03:09:24.018047 | TASK [validate-host : Write out all zuul information for each host] 2026-08-22 03:09:24.780544 | debian-bookworm -> localhost | changed 2026-08-22 03:09:24.788538 | 2026-08-22 03:09:24.788637 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-22 03:09:25.137606 | debian-bookworm | ok 2026-08-22 03:09:25.142243 | 2026-08-22 03:09:25.142338 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-22 03:09:27.488089 | debian-bookworm | changed: 2026-08-22 03:09:27.488285 | debian-bookworm | cd+++++++++ src/ 2026-08-22 03:09:27.488322 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-22 03:09:27.488348 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-22 03:09:27.488370 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-08-22 03:09:27.488390 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/logs" 2026-08-22 03:10:30.663902 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/artifacts" 2026-08-22 03:10:31.054649 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bebd529ed3cf464285831cf22fd296f4/work/docs" 2026-08-22 03:10:31.067538 | 2026-08-22 03:10:31.067802 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-22 03:10:32.100768 | debian-bookworm | changed: 2026-08-22 03:10:32.101139 | debian-bookworm | .d..t...... ./ 2026-08-22 03:10:32.101199 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-22 03:10:32.101224 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-22 03:10:32.103896 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-22 03:10:32.103983 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-22 03:10:32.104010 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-22 03:10:32.104078 | debian-bookworm | changed: All items complete 2026-08-22 03:10:32.104251 | 2026-08-22 03:10:32.956091 | debian-bookworm | changed: .d..t...... ./ 2026-08-22 03:10:33.859205 | debian-bookworm | changed: .d..t...... ./ 2026-08-22 03:10:33.884267 | 2026-08-22 03:10:33.884437 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-22 03:10:33.938400 | debian-bookworm | skipping: Conditional result was False 2026-08-22 03:10:33.947521 | debian-bookworm | skipping: Conditional result was False 2026-08-22 03:10:33.972249 | 2026-08-22 03:10:33.972378 | PLAY RECAP 2026-08-22 03:10:33.972447 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-22 03:10:33.972477 | 2026-08-22 03:10:34.336800 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-22 03:10:34.337729 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 03:10:35.783508 | 2026-08-22 03:10:35.784071 | PLAY [Base post] 2026-08-22 03:10:35.801939 | 2026-08-22 03:10:35.802115 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-22 03:10:36.789005 | debian-bookworm | changed 2026-08-22 03:10:36.797868 | 2026-08-22 03:10:36.798027 | PLAY RECAP 2026-08-22 03:10:36.798091 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 03:10:36.798154 | 2026-08-22 03:10:37.030705 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 03:10:37.031874 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-22 03:10:38.430713 | 2026-08-22 03:10:38.430957 | PLAY [Base post-logs] 2026-08-22 03:10:38.477704 | 2026-08-22 03:10:38.477932 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-22 03:10:39.450785 | localhost | changed 2026-08-22 03:10:39.462461 | 2026-08-22 03:10:39.462693 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-22 03:10:39.502674 | localhost | ok 2026-08-22 03:10:39.507431 | 2026-08-22 03:10:39.508139 | TASK [Set zuul-log-path fact] 2026-08-22 03:10:39.528051 | localhost | ok 2026-08-22 03:10:39.543855 | 2026-08-22 03:10:39.544640 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 03:10:39.582278 | localhost | ok 2026-08-22 03:10:39.588709 | 2026-08-22 03:10:39.588865 | TASK [upload-logs : Create log directories] 2026-08-22 03:10:40.253408 | localhost | changed 2026-08-22 03:10:40.257345 | 2026-08-22 03:10:40.257514 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-22 03:10:40.851218 | localhost -> localhost | ok: Runtime: 0:00:00.012914 2026-08-22 03:10:40.856113 | 2026-08-22 03:10:40.856249 | TASK [upload-logs : Upload logs to log server] 2026-08-22 03:10:41.678106 | localhost | Output suppressed because no_log was given 2026-08-22 03:10:41.680281 | 2026-08-22 03:10:41.680397 | LOOP [upload-logs : Compress console log and json output] 2026-08-22 03:10:41.743687 | localhost | skipping: Conditional result was False 2026-08-22 03:10:41.750565 | localhost | skipping: Conditional result was False 2026-08-22 03:10:41.758640 | 2026-08-22 03:10:41.758781 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-22 03:10:41.825751 | localhost | skipping: Conditional result was False 2026-08-22 03:10:41.826086 | 2026-08-22 03:10:41.831098 | localhost | skipping: Conditional result was False 2026-08-22 03:10:41.837201 | 2026-08-22 03:10:41.837325 | LOOP [upload-logs : Upload console log and json output]