2026-08-19 03:14:15.910615 | Job console starting 2026-08-19 03:14:15.929550 | Updating git repos 2026-08-19 03:14:15.980365 | Cloning repos into workspace 2026-08-19 03:14:16.032268 | Restoring repo states 2026-08-19 03:14:16.042897 | Merging changes 2026-08-19 03:14:16.042927 | Checking out repos 2026-08-19 03:14:16.106853 | Preparing playbooks 2026-08-19 03:14:17.025446 | Running Ansible setup 2026-08-19 03:14:22.027669 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-19 03:14:23.188134 | 2026-08-19 03:14:23.188338 | PLAY [Base pre] 2026-08-19 03:14:23.220056 | 2026-08-19 03:14:23.220246 | TASK [Setup log path fact] 2026-08-19 03:14:23.243284 | debian-bookworm | ok 2026-08-19 03:14:23.267978 | 2026-08-19 03:14:23.268323 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-19 03:14:23.300715 | debian-bookworm | ok 2026-08-19 03:14:23.315891 | 2026-08-19 03:14:23.316058 | TASK [emit-job-header : Print job information] 2026-08-19 03:14:23.358070 | # Job Information 2026-08-19 03:14:23.358330 | Ansible Version: 2.16.14 2026-08-19 03:14:23.360306 | Job: python-black 2026-08-19 03:14:23.360353 | Pipeline: periodic-daily 2026-08-19 03:14:23.360379 | Executor: 521e9411259a 2026-08-19 03:14:23.360400 | Triggered by: https://github.com/osism/cfg-cookiecutter 2026-08-19 03:14:23.360422 | Event ID: 0266ee2a3d124c398cc65261353ce858 2026-08-19 03:14:23.365989 | 2026-08-19 03:14:23.366103 | LOOP [emit-job-header : Print node information] 2026-08-19 03:14:23.500182 | debian-bookworm | ok: 2026-08-19 03:14:23.500448 | debian-bookworm | # Node Information 2026-08-19 03:14:23.500484 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-19 03:14:23.500510 | debian-bookworm | Hostname: debian 2026-08-19 03:14:23.500532 | debian-bookworm | Username: zuul 2026-08-19 03:14:23.500554 | debian-bookworm | Distro: Debian 12.15 2026-08-19 03:14:23.500578 | debian-bookworm | Provider: regiocloud-a 2026-08-19 03:14:23.500600 | debian-bookworm | Region: 2026-08-19 03:14:23.500621 | debian-bookworm | Label: debian-bookworm 2026-08-19 03:14:23.500642 | debian-bookworm | Product Name: OpenStack Nova 2026-08-19 03:14:23.500662 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe31:87de 2026-08-19 03:14:23.522540 | 2026-08-19 03:14:23.522737 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-19 03:14:24.252477 | debian-bookworm -> localhost | changed 2026-08-19 03:14:24.268142 | 2026-08-19 03:14:24.268395 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-19 03:14:25.552474 | debian-bookworm -> localhost | changed 2026-08-19 03:14:25.567993 | 2026-08-19 03:14:25.568131 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-19 03:14:25.871553 | debian-bookworm -> localhost | ok 2026-08-19 03:14:25.888551 | 2026-08-19 03:14:25.888749 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-19 03:14:25.925790 | debian-bookworm | ok 2026-08-19 03:14:25.945132 | debian-bookworm | included: /var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-19 03:14:25.951815 | 2026-08-19 03:14:25.951926 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-19 03:14:27.277555 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-19 03:14:27.277894 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/5585ecd3defd4344ab4dd38665e7bf58_id_rsa 2026-08-19 03:14:27.277953 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/5585ecd3defd4344ab4dd38665e7bf58_id_rsa.pub 2026-08-19 03:14:27.277995 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-19 03:14:27.278034 | debian-bookworm -> localhost | SHA256:eb47lntFz22c/foOVeu0WXysQV1SQNbPBodWpLr0qSw zuul-build-sshkey 2026-08-19 03:14:27.278071 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-19 03:14:27.278128 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-19 03:14:27.278165 | debian-bookworm -> localhost | | .=B=| 2026-08-19 03:14:27.278198 | debian-bookworm -> localhost | | .+++| 2026-08-19 03:14:27.278231 | debian-bookworm -> localhost | | .o++| 2026-08-19 03:14:27.278290 | debian-bookworm -> localhost | | . o.o*| 2026-08-19 03:14:27.278331 | debian-bookworm -> localhost | | S . o..BX| 2026-08-19 03:14:27.278377 | debian-bookworm -> localhost | | o . o+*%| 2026-08-19 03:14:27.278410 | debian-bookworm -> localhost | | ....==.| 2026-08-19 03:14:27.278444 | debian-bookworm -> localhost | | Eo.. ..| 2026-08-19 03:14:27.278476 | debian-bookworm -> localhost | | .+*o .+o| 2026-08-19 03:14:27.278511 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-19 03:14:27.278594 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.707577 2026-08-19 03:14:27.288820 | 2026-08-19 03:14:27.288975 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-19 03:14:27.325320 | debian-bookworm | ok 2026-08-19 03:14:27.341698 | debian-bookworm | included: /var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-19 03:14:27.350635 | 2026-08-19 03:14:27.350751 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-19 03:14:27.386579 | debian-bookworm | skipping: Conditional result was False 2026-08-19 03:14:27.393926 | 2026-08-19 03:14:27.394054 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-19 03:14:28.193642 | debian-bookworm | changed 2026-08-19 03:14:28.201992 | 2026-08-19 03:14:28.202149 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-19 03:14:28.515220 | debian-bookworm | ok 2026-08-19 03:14:28.526084 | 2026-08-19 03:14:28.526229 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-19 03:14:29.200901 | debian-bookworm | changed 2026-08-19 03:14:29.210672 | 2026-08-19 03:14:29.210923 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-19 03:14:29.948253 | debian-bookworm | changed 2026-08-19 03:14:29.954512 | 2026-08-19 03:14:29.954636 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-19 03:14:29.990309 | debian-bookworm | skipping: Conditional result was False 2026-08-19 03:14:30.002162 | 2026-08-19 03:14:30.002350 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-19 03:14:30.526758 | debian-bookworm -> localhost | changed 2026-08-19 03:14:30.539067 | 2026-08-19 03:14:30.539199 | TASK [add-build-sshkey : Add back temp key] 2026-08-19 03:14:30.878686 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/5585ecd3defd4344ab4dd38665e7bf58_id_rsa (zuul-build-sshkey) 2026-08-19 03:14:30.879095 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015077 2026-08-19 03:14:30.887781 | 2026-08-19 03:14:30.887911 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-19 03:14:31.369240 | debian-bookworm | ok 2026-08-19 03:14:31.376200 | 2026-08-19 03:14:31.376392 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-19 03:14:31.401047 | debian-bookworm | skipping: Conditional result was False 2026-08-19 03:14:31.418077 | 2026-08-19 03:14:31.418236 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-19 03:14:31.937403 | debian-bookworm | ok 2026-08-19 03:14:31.949453 | 2026-08-19 03:14:31.949573 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-19 03:14:31.979471 | debian-bookworm | ok 2026-08-19 03:14:31.985074 | 2026-08-19 03:14:31.985196 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-19 03:14:32.506503 | debian-bookworm -> localhost | ok 2026-08-19 03:14:32.514397 | 2026-08-19 03:14:32.514522 | TASK [validate-host : Collect information about the host] 2026-08-19 03:14:34.081325 | debian-bookworm | ok 2026-08-19 03:14:34.118371 | 2026-08-19 03:14:34.118548 | TASK [validate-host : Sanitize hostname] 2026-08-19 03:14:34.467851 | debian-bookworm | ok 2026-08-19 03:14:34.482950 | 2026-08-19 03:14:34.483082 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-19 03:14:36.345868 | debian-bookworm -> localhost | changed 2026-08-19 03:14:36.354413 | 2026-08-19 03:14:36.354556 | TASK [validate-host : Collect information about zuul worker] 2026-08-19 03:14:37.077208 | debian-bookworm | ok 2026-08-19 03:14:37.082602 | 2026-08-19 03:14:37.083688 | TASK [validate-host : Write out all zuul information for each host] 2026-08-19 03:14:38.109486 | debian-bookworm -> localhost | changed 2026-08-19 03:14:38.121452 | 2026-08-19 03:14:38.121547 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-19 03:14:38.451039 | debian-bookworm | ok 2026-08-19 03:14:38.458963 | 2026-08-19 03:14:38.459599 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-19 03:14:39.538127 | debian-bookworm | changed: 2026-08-19 03:14:39.538307 | debian-bookworm | cd+++++++++ src/ 2026-08-19 03:14:39.538335 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-19 03:14:39.538355 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-19 03:14:39.538373 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-08-19 03:14:39.538390 | debian-bookworm | Containerfile 2026-08-19 03:14:39.538497 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/logs" 2026-08-19 03:15:44.914921 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/artifacts" 2026-08-19 03:15:45.205281 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5585ecd3defd4344ab4dd38665e7bf58/work/docs" 2026-08-19 03:15:45.214600 | 2026-08-19 03:15:45.214741 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-19 03:15:45.945566 | debian-bookworm | changed: 2026-08-19 03:15:45.945819 | debian-bookworm | .d..t...... ./ 2026-08-19 03:15:45.945860 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-19 03:15:45.945887 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-19 03:15:45.945911 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-19 03:15:45.945934 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-19 03:15:45.945956 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-19 03:15:45.946016 | debian-bookworm | changed: All items complete 2026-08-19 03:15:45.946048 | 2026-08-19 03:15:46.500163 | debian-bookworm | changed: .d..t...... ./ 2026-08-19 03:15:47.042825 | debian-bookworm | changed: .d..t...... ./ 2026-08-19 03:15:47.065163 | 2026-08-19 03:15:47.065391 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-19 03:15:47.106240 | debian-bookworm | skipping: Conditional result was False 2026-08-19 03:15:47.110928 | debian-bookworm | skipping: Conditional result was False 2026-08-19 03:15:47.129845 | 2026-08-19 03:15:47.129941 | PLAY RECAP 2026-08-19 03:15:47.130005 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-19 03:15:47.130037 | 2026-08-19 03:15:47.251996 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-19 03:15:47.254981 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-19 03:15:48.020238 | 2026-08-19 03:15:48.020438 | PLAY [Base post] 2026-08-19 03:15:48.035394 | 2026-08-19 03:15:48.035560 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-19 03:15:48.671389 | debian-bookworm | changed 2026-08-19 03:15:48.680117 | 2026-08-19 03:15:48.680335 | PLAY RECAP 2026-08-19 03:15:48.680428 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-19 03:15:48.680518 | 2026-08-19 03:15:48.830550 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-19 03:15:48.831533 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-19 03:15:49.670071 | 2026-08-19 03:15:49.670348 | PLAY [Base post-logs] 2026-08-19 03:15:49.686405 | 2026-08-19 03:15:49.686629 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-19 03:15:50.251583 | localhost | changed 2026-08-19 03:15:50.268951 | 2026-08-19 03:15:50.269378 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-19 03:15:50.327830 | localhost | ok 2026-08-19 03:15:50.332863 | 2026-08-19 03:15:50.333001 | TASK [Set zuul-log-path fact] 2026-08-19 03:15:50.373376 | localhost | ok 2026-08-19 03:15:50.393789 | 2026-08-19 03:15:50.393946 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-19 03:15:50.448260 | localhost | ok 2026-08-19 03:15:50.454256 | 2026-08-19 03:15:50.454383 | TASK [upload-logs : Create log directories] 2026-08-19 03:15:51.651666 | localhost | changed 2026-08-19 03:15:51.654946 | 2026-08-19 03:15:51.655070 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-19 03:15:52.991869 | localhost -> localhost | ok: Runtime: 0:00:00.008055 2026-08-19 03:15:52.998634 | 2026-08-19 03:15:52.998762 | TASK [upload-logs : Upload logs to log server] 2026-08-19 03:15:54.119751 | localhost | Output suppressed because no_log was given 2026-08-19 03:15:54.122360 | 2026-08-19 03:15:54.122491 | LOOP [upload-logs : Compress console log and json output] 2026-08-19 03:15:54.198026 | localhost | skipping: Conditional result was False 2026-08-19 03:15:54.222322 | localhost | skipping: Conditional result was False 2026-08-19 03:15:54.233049 | 2026-08-19 03:15:54.233237 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-19 03:15:54.295604 | localhost | skipping: Conditional result was False 2026-08-19 03:15:54.295925 | 2026-08-19 03:15:54.300440 | localhost | skipping: Conditional result was False 2026-08-19 03:15:54.312051 | 2026-08-19 03:15:54.312192 | LOOP [upload-logs : Upload console log and json output]