2026-08-27 12:50:47.695584 | Job console starting 2026-08-27 12:50:47.740096 | Updating git repos 2026-08-27 12:50:47.831351 | Cloning repos into workspace 2026-08-27 12:50:48.013703 | Restoring repo states 2026-08-27 12:50:48.038412 | Merging changes 2026-08-27 12:50:49.073300 | Checking out repos 2026-08-27 12:50:49.223309 | Preparing playbooks 2026-08-27 12:50:51.043048 | Running Ansible setup 2026-08-27 12:50:58.451112 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-27 12:51:00.063960 | 2026-08-27 12:51:00.064104 | PLAY [Base pre] 2026-08-27 12:51:00.114722 | 2026-08-27 12:51:00.114869 | TASK [Setup log path fact] 2026-08-27 12:51:00.143303 | debian-bookworm | ok 2026-08-27 12:51:00.176368 | 2026-08-27 12:51:00.176518 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 12:51:00.231210 | debian-bookworm | ok 2026-08-27 12:51:00.242356 | 2026-08-27 12:51:00.242473 | TASK [emit-job-header : Print job information] 2026-08-27 12:51:00.282960 | # Job Information 2026-08-27 12:51:00.283157 | Ansible Version: 2.16.14 2026-08-27 12:51:00.283196 | Job: python-black 2026-08-27 12:51:00.283231 | Pipeline: check 2026-08-27 12:51:00.283256 | Executor: 521e9411259a 2026-08-27 12:51:00.283278 | Triggered by: https://github.com/osism/python-osism/pull/2629 2026-08-27 12:51:00.283301 | Event ID: e6488000-a215-11f1-888d-ea56d1dcbdc2 2026-08-27 12:51:00.288324 | 2026-08-27 12:51:00.288427 | LOOP [emit-job-header : Print node information] 2026-08-27 12:51:00.418949 | debian-bookworm | ok: 2026-08-27 12:51:00.419114 | debian-bookworm | # Node Information 2026-08-27 12:51:00.419142 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-27 12:51:00.419164 | debian-bookworm | Hostname: debian 2026-08-27 12:51:00.419183 | debian-bookworm | Username: zuul 2026-08-27 12:51:00.419201 | debian-bookworm | Distro: Debian 12.15 2026-08-27 12:51:00.419222 | debian-bookworm | Provider: regiocloud-a 2026-08-27 12:51:00.419240 | debian-bookworm | Region: 2026-08-27 12:51:00.419258 | debian-bookworm | Label: debian-bookworm 2026-08-27 12:51:00.419275 | debian-bookworm | Product Name: OpenStack Nova 2026-08-27 12:51:00.419291 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:65ad 2026-08-27 12:51:00.433781 | 2026-08-27 12:51:00.433890 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-27 12:51:01.191909 | debian-bookworm -> localhost | changed 2026-08-27 12:51:01.209433 | 2026-08-27 12:51:01.209690 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-27 12:51:03.587138 | debian-bookworm -> localhost | changed 2026-08-27 12:51:03.596005 | 2026-08-27 12:51:03.596092 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-27 12:51:04.587919 | debian-bookworm -> localhost | ok 2026-08-27 12:51:04.593233 | 2026-08-27 12:51:04.593338 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-27 12:51:04.643237 | debian-bookworm | ok 2026-08-27 12:51:04.671921 | debian-bookworm | included: /var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-27 12:51:04.697777 | 2026-08-27 12:51:04.697888 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-27 12:51:06.360752 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-27 12:51:06.360979 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/c87fa23b255043aa8efacab6c1ea30a5_id_rsa 2026-08-27 12:51:06.361018 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/c87fa23b255043aa8efacab6c1ea30a5_id_rsa.pub 2026-08-27 12:51:06.361046 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-27 12:51:06.361072 | debian-bookworm -> localhost | SHA256:52lPwsmNEjrzkLNpJDe1GDObOYWlYBlfXU4s9qNWjTs zuul-build-sshkey 2026-08-27 12:51:06.361096 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-27 12:51:06.361129 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-27 12:51:06.361152 | debian-bookworm -> localhost | | .o .. oo | 2026-08-27 12:51:06.361174 | debian-bookworm -> localhost | | +. .. +o. | 2026-08-27 12:51:06.361194 | debian-bookworm -> localhost | | . ..+ . o.o | 2026-08-27 12:51:06.361214 | debian-bookworm -> localhost | | * o = . | 2026-08-27 12:51:06.361234 | debian-bookworm -> localhost | | @S..o o | 2026-08-27 12:51:06.361259 | debian-bookworm -> localhost | | . Xo.*o=E | 2026-08-27 12:51:06.361280 | debian-bookworm -> localhost | | +Bo..X o. | 2026-08-27 12:51:06.361299 | debian-bookworm -> localhost | | .O o + | 2026-08-27 12:51:06.361320 | debian-bookworm -> localhost | | .o . . | 2026-08-27 12:51:06.361340 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-27 12:51:06.361394 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.584823 2026-08-27 12:51:06.368297 | 2026-08-27 12:51:06.368402 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-27 12:51:06.426349 | debian-bookworm | ok 2026-08-27 12:51:06.453023 | debian-bookworm | included: /var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-27 12:51:06.485304 | 2026-08-27 12:51:06.485421 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-27 12:51:06.532703 | debian-bookworm | skipping: Conditional result was False 2026-08-27 12:51:06.543297 | 2026-08-27 12:51:06.543429 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-27 12:51:07.456935 | debian-bookworm | changed 2026-08-27 12:51:07.462405 | 2026-08-27 12:51:07.462509 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-27 12:51:07.715220 | debian-bookworm | ok 2026-08-27 12:51:07.726852 | 2026-08-27 12:51:07.726963 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-27 12:51:08.413635 | debian-bookworm | changed 2026-08-27 12:51:08.419049 | 2026-08-27 12:51:08.419140 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-27 12:51:09.087883 | debian-bookworm | changed 2026-08-27 12:51:09.095284 | 2026-08-27 12:51:09.095401 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-27 12:51:09.118797 | debian-bookworm | skipping: Conditional result was False 2026-08-27 12:51:09.124809 | 2026-08-27 12:51:09.124901 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-27 12:51:10.049903 | debian-bookworm -> localhost | changed 2026-08-27 12:51:10.063422 | 2026-08-27 12:51:10.063534 | TASK [add-build-sshkey : Add back temp key] 2026-08-27 12:51:10.729140 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/c87fa23b255043aa8efacab6c1ea30a5_id_rsa (zuul-build-sshkey) 2026-08-27 12:51:10.729369 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035526 2026-08-27 12:51:10.737009 | 2026-08-27 12:51:10.737107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-27 12:51:11.429695 | debian-bookworm | ok 2026-08-27 12:51:11.450489 | 2026-08-27 12:51:11.450641 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-27 12:51:11.485064 | debian-bookworm | skipping: Conditional result was False 2026-08-27 12:51:11.502540 | 2026-08-27 12:51:11.502686 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-27 12:51:12.133913 | debian-bookworm | ok 2026-08-27 12:51:12.163225 | 2026-08-27 12:51:12.163384 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-27 12:51:12.235807 | debian-bookworm | ok 2026-08-27 12:51:12.246142 | 2026-08-27 12:51:12.246279 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-27 12:51:12.965089 | debian-bookworm -> localhost | ok 2026-08-27 12:51:12.971693 | 2026-08-27 12:51:12.971791 | TASK [validate-host : Collect information about the host] 2026-08-27 12:51:14.399067 | debian-bookworm | ok 2026-08-27 12:51:14.447751 | 2026-08-27 12:51:14.447884 | TASK [validate-host : Sanitize hostname] 2026-08-27 12:51:14.674966 | debian-bookworm | ok 2026-08-27 12:51:14.679645 | 2026-08-27 12:51:14.679739 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-27 12:51:15.902412 | debian-bookworm -> localhost | changed 2026-08-27 12:51:15.911853 | 2026-08-27 12:51:15.911961 | TASK [validate-host : Collect information about zuul worker] 2026-08-27 12:51:16.472855 | debian-bookworm | ok 2026-08-27 12:51:16.477597 | 2026-08-27 12:51:16.477711 | TASK [validate-host : Write out all zuul information for each host] 2026-08-27 12:51:17.470448 | debian-bookworm -> localhost | changed 2026-08-27 12:51:17.484790 | 2026-08-27 12:51:17.484899 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-27 12:51:17.819688 | debian-bookworm | ok 2026-08-27 12:51:17.848548 | 2026-08-27 12:51:17.848716 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-27 12:51:20.271307 | debian-bookworm | changed: 2026-08-27 12:51:20.271497 | debian-bookworm | cd+++++++++ src/ 2026-08-27 12:51:20.271532 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-27 12:51:20.271557 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-27 12:51:20.271589 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-27 12:51:20.271636 | debian-bookworm | Containerfile 2026-08-27 12:51:20.271833 | debian-bookworm | Containerfile 2026-08-27 12:51:20.310360 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/logs" 2026-08-27 12:52:35.432034 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/artifacts" 2026-08-27 12:52:35.688967 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c87fa23b255043aa8efacab6c1ea30a5/work/docs" 2026-08-27 12:52:35.708740 | 2026-08-27 12:52:35.708915 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-27 12:52:36.659389 | debian-bookworm | changed: 2026-08-27 12:52:36.659969 | debian-bookworm | .d..t...... ./ 2026-08-27 12:52:36.660028 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-27 12:52:36.660245 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-27 12:52:36.660364 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-27 12:52:36.660395 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-27 12:52:36.660418 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-27 12:52:36.660478 | debian-bookworm | changed: All items complete 2026-08-27 12:52:36.660649 | 2026-08-27 12:52:37.266023 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 12:52:37.869372 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 12:52:37.892885 | 2026-08-27 12:52:37.893057 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-27 12:52:38.268749 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.013569 2026-08-27 12:52:38.612071 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012227 2026-08-27 12:52:38.635089 | 2026-08-27 12:52:38.635301 | PLAY RECAP 2026-08-27 12:52:38.635380 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-27 12:52:38.635416 | 2026-08-27 12:52:38.799478 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-27 12:52:38.801592 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 12:52:39.661827 | 2026-08-27 12:52:39.662044 | PLAY [Base post] 2026-08-27 12:52:39.683811 | 2026-08-27 12:52:39.684097 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-27 12:52:40.337235 | debian-bookworm | changed 2026-08-27 12:52:40.349588 | 2026-08-27 12:52:40.349782 | PLAY RECAP 2026-08-27 12:52:40.349874 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-27 12:52:40.349963 | 2026-08-27 12:52:40.491288 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 12:52:40.493430 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-27 12:52:41.364266 | 2026-08-27 12:52:41.364466 | PLAY [Base post-logs] 2026-08-27 12:52:41.375868 | 2026-08-27 12:52:41.376011 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-27 12:52:41.874763 | localhost | changed 2026-08-27 12:52:41.890785 | 2026-08-27 12:52:41.891165 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-27 12:52:41.918436 | localhost | ok 2026-08-27 12:52:41.924373 | 2026-08-27 12:52:41.924497 | TASK [Set zuul-log-path fact] 2026-08-27 12:52:41.940282 | localhost | ok 2026-08-27 12:52:41.948598 | 2026-08-27 12:52:41.948725 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 12:52:41.973761 | localhost | ok 2026-08-27 12:52:41.976823 | 2026-08-27 12:52:41.976927 | TASK [upload-logs : Create log directories] 2026-08-27 12:52:42.540775 | localhost | changed 2026-08-27 12:52:42.545525 | 2026-08-27 12:52:42.545741 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-27 12:52:43.108327 | localhost -> localhost | ok: Runtime: 0:00:00.007968 2026-08-27 12:52:43.113333 | 2026-08-27 12:52:43.113460 | TASK [upload-logs : Upload logs to log server] 2026-08-27 12:52:43.736122 | localhost | Output suppressed because no_log was given 2026-08-27 12:52:43.738345 | 2026-08-27 12:52:43.738537 | LOOP [upload-logs : Compress console log and json output] 2026-08-27 12:52:43.787430 | localhost | skipping: Conditional result was False 2026-08-27 12:52:43.793279 | localhost | skipping: Conditional result was False 2026-08-27 12:52:43.808740 | 2026-08-27 12:52:43.809089 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-27 12:52:43.869621 | localhost | skipping: Conditional result was False 2026-08-27 12:52:43.869980 | 2026-08-27 12:52:43.885209 | localhost | skipping: Conditional result was False 2026-08-27 12:52:43.892256 | 2026-08-27 12:52:43.892478 | LOOP [upload-logs : Upload console log and json output]