2026-10-04 21:53:23.970179 | Job console starting 2026-10-04 21:53:23.988624 | Updating git repos 2026-10-04 21:53:24.010234 | Cloning repos into workspace 2026-10-04 21:53:24.089344 | Restoring repo states 2026-10-04 21:53:24.099583 | Merging changes 2026-10-04 21:53:24.610016 | Checking out repos 2026-10-04 21:53:24.651211 | Preparing playbooks 2026-10-04 21:53:25.355566 | Running Ansible setup 2026-10-04 21:53:29.855484 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-04 21:53:30.682471 | 2026-10-04 21:53:30.682680 | PLAY [Base pre] 2026-10-04 21:53:30.704013 | 2026-10-04 21:53:30.704156 | TASK [Setup log path fact] 2026-10-04 21:53:30.733475 | debian-bookworm | ok 2026-10-04 21:53:30.754682 | 2026-10-04 21:53:30.754844 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-04 21:53:30.793747 | debian-bookworm | ok 2026-10-04 21:53:30.803849 | 2026-10-04 21:53:30.803974 | TASK [emit-job-header : Print job information] 2026-10-04 21:53:30.843060 | # Job Information 2026-10-04 21:53:30.843260 | Ansible Version: 2.16.14 2026-10-04 21:53:30.843296 | Job: python-black 2026-10-04 21:53:30.843329 | Pipeline: check 2026-10-04 21:53:30.843353 | Executor: 521e9411259a 2026-10-04 21:53:30.843374 | Triggered by: https://github.com/osism/zuul-jobs/pull/184 2026-10-04 21:53:30.843397 | Event ID: ff6170b0-c03d-11f1-83eb-b9e5ff1bdc31 2026-10-04 21:53:30.848485 | 2026-10-04 21:53:30.848606 | LOOP [emit-job-header : Print node information] 2026-10-04 21:53:30.954138 | debian-bookworm | ok: 2026-10-04 21:53:30.954361 | debian-bookworm | # Node Information 2026-10-04 21:53:30.954441 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-04 21:53:30.954470 | debian-bookworm | Hostname: debian 2026-10-04 21:53:30.954493 | debian-bookworm | Username: zuul 2026-10-04 21:53:30.954514 | debian-bookworm | Distro: Debian 12.15 2026-10-04 21:53:30.954538 | debian-bookworm | Provider: regiocloud-a 2026-10-04 21:53:30.954560 | debian-bookworm | Region: 2026-10-04 21:53:30.954582 | debian-bookworm | Label: debian-bookworm 2026-10-04 21:53:30.954602 | debian-bookworm | Product Name: OpenStack Nova 2026-10-04 21:53:30.954639 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed9:abb7 2026-10-04 21:53:30.985166 | 2026-10-04 21:53:30.985304 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-04 21:53:31.495407 | debian-bookworm -> localhost | changed 2026-10-04 21:53:31.503065 | 2026-10-04 21:53:31.503259 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-04 21:53:32.685204 | debian-bookworm -> localhost | changed 2026-10-04 21:53:32.696318 | 2026-10-04 21:53:32.696433 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-04 21:53:32.956154 | debian-bookworm -> localhost | ok 2026-10-04 21:53:32.962566 | 2026-10-04 21:53:32.962705 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-04 21:53:32.993693 | debian-bookworm | ok 2026-10-04 21:53:33.009804 | debian-bookworm | included: /var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-04 21:53:33.016058 | 2026-10-04 21:53:33.016162 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-04 21:53:34.435239 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-04 21:53:34.435410 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/20aba143cbd642908eba307d008967d6_id_rsa 2026-10-04 21:53:34.435440 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/20aba143cbd642908eba307d008967d6_id_rsa.pub 2026-10-04 21:53:34.435461 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-04 21:53:34.435481 | debian-bookworm -> localhost | SHA256:PU4g8VKcbK/sfPtTP0g9BIMCP9qOQXtDgevWWMmoFc0 zuul-build-sshkey 2026-10-04 21:53:34.435500 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-04 21:53:34.435530 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-04 21:53:34.435548 | debian-bookworm -> localhost | | .+*o . | 2026-10-04 21:53:34.435566 | debian-bookworm -> localhost | | **E.. o | 2026-10-04 21:53:34.435583 | debian-bookworm -> localhost | | ooB=o o | 2026-10-04 21:53:34.435598 | debian-bookworm -> localhost | | .*=*o . | 2026-10-04 21:53:34.435613 | debian-bookworm -> localhost | | +=S=+ o | 2026-10-04 21:53:34.435644 | debian-bookworm -> localhost | | . +B+.. ..o | 2026-10-04 21:53:34.435661 | debian-bookworm -> localhost | | .+ .. .....| 2026-10-04 21:53:34.435676 | debian-bookworm -> localhost | | o . .. ..| 2026-10-04 21:53:34.435693 | debian-bookworm -> localhost | | ..o.. .| 2026-10-04 21:53:34.435709 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-04 21:53:34.435751 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.804957 2026-10-04 21:53:34.440762 | 2026-10-04 21:53:34.440839 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-04 21:53:34.456782 | debian-bookworm | ok 2026-10-04 21:53:34.464753 | debian-bookworm | included: /var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-04 21:53:34.471107 | 2026-10-04 21:53:34.471176 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-04 21:53:34.483466 | debian-bookworm | skipping: Conditional result was False 2026-10-04 21:53:34.487967 | 2026-10-04 21:53:34.488037 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-04 21:53:35.128198 | debian-bookworm | changed 2026-10-04 21:53:35.136946 | 2026-10-04 21:53:35.137062 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-04 21:53:35.418563 | debian-bookworm | ok 2026-10-04 21:53:35.427706 | 2026-10-04 21:53:35.427843 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-04 21:53:36.116355 | debian-bookworm | changed 2026-10-04 21:53:36.125244 | 2026-10-04 21:53:36.125385 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-04 21:53:36.784341 | debian-bookworm | changed 2026-10-04 21:53:36.789677 | 2026-10-04 21:53:36.789764 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-04 21:53:36.812391 | debian-bookworm | skipping: Conditional result was False 2026-10-04 21:53:36.818434 | 2026-10-04 21:53:36.818523 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-04 21:53:37.205852 | debian-bookworm -> localhost | changed 2026-10-04 21:53:37.215974 | 2026-10-04 21:53:37.216068 | TASK [add-build-sshkey : Add back temp key] 2026-10-04 21:53:37.546922 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/20aba143cbd642908eba307d008967d6_id_rsa (zuul-build-sshkey) 2026-10-04 21:53:37.547126 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009586 2026-10-04 21:53:37.554788 | 2026-10-04 21:53:37.554879 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-04 21:53:37.943869 | debian-bookworm | ok 2026-10-04 21:53:37.953368 | 2026-10-04 21:53:37.953492 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-04 21:53:37.976698 | debian-bookworm | skipping: Conditional result was False 2026-10-04 21:53:37.986338 | 2026-10-04 21:53:37.986423 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-04 21:53:38.397409 | debian-bookworm | ok 2026-10-04 21:53:38.413782 | 2026-10-04 21:53:38.413890 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-04 21:53:38.441154 | debian-bookworm | ok 2026-10-04 21:53:38.455068 | 2026-10-04 21:53:38.455158 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-04 21:53:38.720320 | debian-bookworm -> localhost | ok 2026-10-04 21:53:38.726729 | 2026-10-04 21:53:38.726821 | TASK [validate-host : Collect information about the host] 2026-10-04 21:53:39.797591 | debian-bookworm | ok 2026-10-04 21:53:39.814338 | 2026-10-04 21:53:39.814465 | TASK [validate-host : Sanitize hostname] 2026-10-04 21:53:39.968294 | debian-bookworm | ok 2026-10-04 21:53:39.973022 | 2026-10-04 21:53:39.973128 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-04 21:53:40.563982 | debian-bookworm -> localhost | changed 2026-10-04 21:53:40.569844 | 2026-10-04 21:53:40.569961 | TASK [validate-host : Collect information about zuul worker] 2026-10-04 21:53:40.987010 | debian-bookworm | ok 2026-10-04 21:53:40.993061 | 2026-10-04 21:53:40.993185 | TASK [validate-host : Write out all zuul information for each host] 2026-10-04 21:53:41.568040 | debian-bookworm -> localhost | changed 2026-10-04 21:53:41.584462 | 2026-10-04 21:53:41.584610 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-04 21:53:41.861799 | debian-bookworm | ok 2026-10-04 21:53:41.871577 | 2026-10-04 21:53:41.871749 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-04 21:53:42.730704 | debian-bookworm | changed: 2026-10-04 21:53:42.730916 | debian-bookworm | cd+++++++++ src/ 2026-10-04 21:53:42.730951 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-04 21:53:42.730976 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-04 21:53:42.730997 | debian-bookworm | cd+++++++++ src/github.com/osism/zuul-jobs/ 2026-10-04 21:53:42.731017 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/logs" 2026-10-04 21:54:40.773886 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/artifacts" 2026-10-04 21:54:41.047437 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/20aba143cbd642908eba307d008967d6/work/docs" 2026-10-04 21:54:41.057343 | 2026-10-04 21:54:41.057459 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-04 21:54:41.850798 | debian-bookworm | changed: 2026-10-04 21:54:41.851056 | debian-bookworm | .d..t...... ./ 2026-10-04 21:54:41.851100 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-04 21:54:41.851216 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-04 21:54:41.851253 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-04 21:54:41.851281 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-04 21:54:41.851306 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-04 21:54:41.851356 | debian-bookworm | changed: All items complete 2026-10-04 21:54:41.851389 | 2026-10-04 21:54:42.418407 | debian-bookworm | changed: .d..t...... ./ 2026-10-04 21:54:43.006885 | debian-bookworm | changed: .d..t...... ./ 2026-10-04 21:54:43.037881 | 2026-10-04 21:54:43.038021 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-04 21:54:43.363279 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006660 2026-10-04 21:54:43.637506 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008403 2026-10-04 21:54:43.656279 | 2026-10-04 21:54:43.656457 | PLAY RECAP 2026-10-04 21:54:43.656511 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-04 21:54:43.656535 | 2026-10-04 21:54:43.784982 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-04 21:54:43.785914 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-04 21:54:44.548904 | 2026-10-04 21:54:44.549063 | PLAY [Base post] 2026-10-04 21:54:44.562667 | 2026-10-04 21:54:44.562843 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-04 21:54:45.118874 | debian-bookworm | changed 2026-10-04 21:54:45.131098 | 2026-10-04 21:54:45.131231 | PLAY RECAP 2026-10-04 21:54:45.131299 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-04 21:54:45.131362 | 2026-10-04 21:54:45.257695 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-04 21:54:45.258680 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-04 21:54:46.039606 | 2026-10-04 21:54:46.039793 | PLAY [Base post-logs] 2026-10-04 21:54:46.050250 | 2026-10-04 21:54:46.050385 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-04 21:54:46.508519 | localhost | changed 2026-10-04 21:54:46.518961 | 2026-10-04 21:54:46.519114 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-04 21:54:46.544904 | localhost | ok 2026-10-04 21:54:46.547958 | 2026-10-04 21:54:46.548067 | TASK [Set zuul-log-path fact] 2026-10-04 21:54:46.563102 | localhost | ok 2026-10-04 21:54:46.571045 | 2026-10-04 21:54:46.571161 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-04 21:54:46.596412 | localhost | ok 2026-10-04 21:54:46.599504 | 2026-10-04 21:54:46.599611 | TASK [upload-logs : Create log directories] 2026-10-04 21:54:47.086015 | localhost | changed 2026-10-04 21:54:47.088791 | 2026-10-04 21:54:47.088893 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-04 21:54:47.570140 | localhost -> localhost | ok: Runtime: 0:00:00.004098 2026-10-04 21:54:47.575061 | 2026-10-04 21:54:47.575186 | TASK [upload-logs : Upload logs to log server] 2026-10-04 21:54:48.205990 | localhost | Output suppressed because no_log was given 2026-10-04 21:54:48.208940 | 2026-10-04 21:54:48.209096 | LOOP [upload-logs : Compress console log and json output] 2026-10-04 21:54:48.264972 | localhost | skipping: Conditional result was False 2026-10-04 21:54:48.272007 | localhost | skipping: Conditional result was False 2026-10-04 21:54:48.279630 | 2026-10-04 21:54:48.279760 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-04 21:54:48.323143 | localhost | skipping: Conditional result was False 2026-10-04 21:54:48.323508 | 2026-10-04 21:54:48.328125 | localhost | skipping: Conditional result was False 2026-10-04 21:54:48.337231 | 2026-10-04 21:54:48.337389 | LOOP [upload-logs : Upload console log and json output]