2026-05-26 03:16:32.085923 | Job console starting 2026-05-26 03:16:32.100362 | Updating git repos 2026-05-26 03:16:32.143570 | Cloning repos into workspace 2026-05-26 03:16:32.286638 | Restoring repo states 2026-05-26 03:16:32.307938 | Merging changes 2026-05-26 03:16:32.307960 | Checking out repos 2026-05-26 03:16:32.401957 | Preparing playbooks 2026-05-26 03:16:34.328166 | Running Ansible setup 2026-05-26 03:16:41.703319 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-26 03:16:42.887770 | 2026-05-26 03:16:42.887881 | PLAY [Base pre] 2026-05-26 03:16:42.902819 | 2026-05-26 03:16:42.902933 | TASK [Setup log path fact] 2026-05-26 03:16:42.920422 | debian-bookworm | ok 2026-05-26 03:16:42.934722 | 2026-05-26 03:16:42.934823 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:16:42.964410 | debian-bookworm | ok 2026-05-26 03:16:42.973585 | 2026-05-26 03:16:42.973686 | TASK [emit-job-header : Print job information] 2026-05-26 03:16:43.024567 | # Job Information 2026-05-26 03:16:43.024710 | Ansible Version: 2.16.14 2026-05-26 03:16:43.024741 | Job: python-black 2026-05-26 03:16:43.024769 | Pipeline: periodic-daily 2026-05-26 03:16:43.024788 | Executor: 521e9411259a 2026-05-26 03:16:43.024806 | Triggered by: https://github.com/osism/mappings 2026-05-26 03:16:43.024825 | Event ID: c18d5cd2183c4e73b356475070556bc4 2026-05-26 03:16:43.028802 | 2026-05-26 03:16:43.028886 | LOOP [emit-job-header : Print node information] 2026-05-26 03:16:43.133159 | debian-bookworm | ok: 2026-05-26 03:16:43.133374 | debian-bookworm | # Node Information 2026-05-26 03:16:43.133405 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-26 03:16:43.133426 | debian-bookworm | Hostname: debian 2026-05-26 03:16:43.133445 | debian-bookworm | Username: zuul 2026-05-26 03:16:43.133462 | debian-bookworm | Distro: Debian 12.14 2026-05-26 03:16:43.133484 | debian-bookworm | Provider: regiocloud-a 2026-05-26 03:16:43.133502 | debian-bookworm | Region: 2026-05-26 03:16:43.133519 | debian-bookworm | Label: debian-bookworm 2026-05-26 03:16:43.133535 | debian-bookworm | Product Name: OpenStack Nova 2026-05-26 03:16:43.133551 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feeb:18e1 2026-05-26 03:16:43.158115 | 2026-05-26 03:16:43.158218 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-26 03:16:43.617100 | debian-bookworm -> localhost | changed 2026-05-26 03:16:43.634576 | 2026-05-26 03:16:43.634685 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-26 03:16:45.909189 | debian-bookworm -> localhost | changed 2026-05-26 03:16:45.920283 | 2026-05-26 03:16:45.921888 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-26 03:16:46.537730 | debian-bookworm -> localhost | ok 2026-05-26 03:16:46.543426 | 2026-05-26 03:16:46.543539 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-26 03:16:46.593806 | debian-bookworm | ok 2026-05-26 03:16:46.620333 | debian-bookworm | included: /var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-26 03:16:46.625664 | 2026-05-26 03:16:46.625758 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-26 03:16:49.709201 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-26 03:16:49.709443 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/e41c9fe7297a40a1a6b8e2623873686e_id_rsa 2026-05-26 03:16:49.709478 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/e41c9fe7297a40a1a6b8e2623873686e_id_rsa.pub 2026-05-26 03:16:49.709500 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-26 03:16:49.709520 | debian-bookworm -> localhost | SHA256:lmkICAmcZCa9fSWg4+2PzQDW6/v9a8Gif/BK6eJ0KHU zuul-build-sshkey 2026-05-26 03:16:49.709539 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-26 03:16:49.709564 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-26 03:16:49.709581 | debian-bookworm -> localhost | |B*. .. | 2026-05-26 03:16:49.709599 | debian-bookworm -> localhost | |=+.o . . | 2026-05-26 03:16:49.709615 | debian-bookworm -> localhost | | +o. o | 2026-05-26 03:16:49.709631 | debian-bookworm -> localhost | | ..+.... o | 2026-05-26 03:16:49.709647 | debian-bookworm -> localhost | | + o.o E. | 2026-05-26 03:16:49.709669 | debian-bookworm -> localhost | | . o o =o.o | 2026-05-26 03:16:49.709685 | debian-bookworm -> localhost | | = o.++ . | 2026-05-26 03:16:49.709701 | debian-bookworm -> localhost | | . Oo= + | 2026-05-26 03:16:49.709718 | debian-bookworm -> localhost | | ++*o==o. | 2026-05-26 03:16:49.709734 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-26 03:16:49.709784 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.105949 2026-05-26 03:16:49.716049 | 2026-05-26 03:16:49.716142 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-26 03:16:49.797791 | debian-bookworm | ok 2026-05-26 03:16:49.809210 | debian-bookworm | included: /var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-26 03:16:49.823677 | 2026-05-26 03:16:49.823777 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-26 03:16:49.846994 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:16:49.853104 | 2026-05-26 03:16:49.853238 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-26 03:16:50.608823 | debian-bookworm | changed 2026-05-26 03:16:50.613342 | 2026-05-26 03:16:50.613418 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-26 03:16:50.886046 | debian-bookworm | ok 2026-05-26 03:16:50.891015 | 2026-05-26 03:16:50.891119 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-26 03:16:51.664690 | debian-bookworm | changed 2026-05-26 03:16:51.679536 | 2026-05-26 03:16:51.679642 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-26 03:16:52.496864 | debian-bookworm | changed 2026-05-26 03:16:52.501247 | 2026-05-26 03:16:52.501318 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-26 03:16:52.575557 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:16:52.581277 | 2026-05-26 03:16:52.581363 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-26 03:16:53.625455 | debian-bookworm -> localhost | changed 2026-05-26 03:16:53.638046 | 2026-05-26 03:16:53.638144 | TASK [add-build-sshkey : Add back temp key] 2026-05-26 03:16:54.397974 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/e41c9fe7297a40a1a6b8e2623873686e_id_rsa (zuul-build-sshkey) 2026-05-26 03:16:54.398174 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.059666 2026-05-26 03:16:54.404614 | 2026-05-26 03:16:54.404699 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-26 03:16:54.891799 | debian-bookworm | ok 2026-05-26 03:16:54.896684 | 2026-05-26 03:16:54.896765 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-26 03:16:54.939703 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:16:54.949039 | 2026-05-26 03:16:54.949140 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-26 03:16:55.523239 | debian-bookworm | ok 2026-05-26 03:16:55.538519 | 2026-05-26 03:16:55.538856 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-26 03:16:55.604362 | debian-bookworm | ok 2026-05-26 03:16:55.618033 | 2026-05-26 03:16:55.618492 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-26 03:16:56.038968 | debian-bookworm -> localhost | ok 2026-05-26 03:16:56.044840 | 2026-05-26 03:16:56.044958 | TASK [validate-host : Collect information about the host] 2026-05-26 03:16:57.417680 | debian-bookworm | ok 2026-05-26 03:16:57.438366 | 2026-05-26 03:16:57.438470 | TASK [validate-host : Sanitize hostname] 2026-05-26 03:16:57.764344 | debian-bookworm | ok 2026-05-26 03:16:57.894611 | 2026-05-26 03:16:57.894715 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-26 03:16:59.398085 | debian-bookworm -> localhost | changed 2026-05-26 03:16:59.402596 | 2026-05-26 03:16:59.402679 | TASK [validate-host : Collect information about zuul worker] 2026-05-26 03:16:59.959547 | debian-bookworm | ok 2026-05-26 03:16:59.964591 | 2026-05-26 03:16:59.964685 | TASK [validate-host : Write out all zuul information for each host] 2026-05-26 03:17:01.065741 | debian-bookworm -> localhost | changed 2026-05-26 03:17:01.073689 | 2026-05-26 03:17:01.073779 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-26 03:17:01.416131 | debian-bookworm | ok 2026-05-26 03:17:01.421667 | 2026-05-26 03:17:01.421752 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-26 03:17:02.312148 | debian-bookworm | changed: 2026-05-26 03:17:02.312286 | debian-bookworm | cd+++++++++ src/ 2026-05-26 03:17:02.312313 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-26 03:17:02.312332 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-26 03:17:02.312349 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/ 2026-05-26 03:17:02.312366 | debian-bookworm | Containerfile 2026-05-26 03:17:02.312427 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/logs" 2026-05-26 03:17:27.914375 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/artifacts" 2026-05-26 03:17:28.234107 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e41c9fe7297a40a1a6b8e2623873686e/work/docs" 2026-05-26 03:17:28.252275 | 2026-05-26 03:17:28.252433 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-26 03:17:29.297111 | debian-bookworm | changed: 2026-05-26 03:17:29.297359 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-26 03:17:29.297395 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-26 03:17:29.297424 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-26 03:17:29.297469 | debian-bookworm | changed: All items complete 2026-05-26 03:17:29.297495 | 2026-05-26 03:17:30.251278 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:17:31.423807 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:17:31.455462 | 2026-05-26 03:17:31.455614 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-26 03:17:31.488644 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:17:31.491511 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:17:31.509786 | 2026-05-26 03:17:31.509941 | PLAY RECAP 2026-05-26 03:17:31.510001 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-26 03:17:31.510026 | 2026-05-26 03:17:31.691235 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 03:17:31.692136 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:17:32.525207 | 2026-05-26 03:17:32.525405 | PLAY [Base post] 2026-05-26 03:17:32.570697 | 2026-05-26 03:17:32.574412 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-26 03:17:33.197657 | debian-bookworm | changed 2026-05-26 03:17:33.210108 | 2026-05-26 03:17:33.210256 | PLAY RECAP 2026-05-26 03:17:33.210325 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-26 03:17:33.210390 | 2026-05-26 03:17:33.410870 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:17:33.412295 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-26 03:17:34.418296 | 2026-05-26 03:17:34.418499 | PLAY [Base post-logs] 2026-05-26 03:17:34.430482 | 2026-05-26 03:17:34.430650 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-26 03:17:35.060771 | localhost | changed 2026-05-26 03:17:35.079119 | 2026-05-26 03:17:35.079292 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-26 03:17:35.108101 | localhost | ok 2026-05-26 03:17:35.119088 | 2026-05-26 03:17:35.119391 | TASK [Set zuul-log-path fact] 2026-05-26 03:17:35.141236 | localhost | ok 2026-05-26 03:17:35.152288 | 2026-05-26 03:17:35.152436 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:17:35.190155 | localhost | ok 2026-05-26 03:17:35.195502 | 2026-05-26 03:17:35.195666 | TASK [upload-logs : Create log directories] 2026-05-26 03:17:35.800243 | localhost | changed 2026-05-26 03:17:35.804309 | 2026-05-26 03:17:35.804431 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-26 03:17:36.374436 | localhost -> localhost | ok: Runtime: 0:00:00.009109 2026-05-26 03:17:36.378756 | 2026-05-26 03:17:36.378926 | TASK [upload-logs : Upload logs to log server] 2026-05-26 03:17:36.989251 | localhost | Output suppressed because no_log was given 2026-05-26 03:17:36.991390 | 2026-05-26 03:17:36.991511 | LOOP [upload-logs : Compress console log and json output] 2026-05-26 03:17:37.047889 | localhost | skipping: Conditional result was False 2026-05-26 03:17:37.056895 | localhost | skipping: Conditional result was False 2026-05-26 03:17:37.061533 | 2026-05-26 03:17:37.061666 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-26 03:17:37.126872 | localhost | skipping: Conditional result was False 2026-05-26 03:17:37.128137 | 2026-05-26 03:17:37.133023 | localhost | skipping: Conditional result was False 2026-05-26 03:17:37.141658 | 2026-05-26 03:17:37.141848 | LOOP [upload-logs : Upload console log and json output]