2026-08-25 17:43:17.322665 | Job console starting 2026-08-25 17:43:17.350130 | Updating git repos 2026-08-25 17:43:17.444480 | Cloning repos into workspace 2026-08-25 17:43:17.522453 | Restoring repo states 2026-08-25 17:43:17.559560 | Merging changes 2026-08-25 17:43:18.404399 | Checking out repos 2026-08-25 17:43:18.490938 | Preparing playbooks 2026-08-25 17:43:20.066196 | Running Ansible setup 2026-08-25 17:43:27.021993 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-25 17:43:28.051396 | 2026-08-25 17:43:28.051543 | PLAY [Base pre] 2026-08-25 17:43:28.089588 | 2026-08-25 17:43:28.089729 | TASK [Setup log path fact] 2026-08-25 17:43:28.128863 | debian-bookworm | ok 2026-08-25 17:43:28.155640 | 2026-08-25 17:43:28.155782 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-25 17:43:28.204071 | debian-bookworm | ok 2026-08-25 17:43:28.222408 | 2026-08-25 17:43:28.222527 | TASK [emit-job-header : Print job information] 2026-08-25 17:43:28.292207 | # Job Information 2026-08-25 17:43:28.292374 | Ansible Version: 2.16.14 2026-08-25 17:43:28.292410 | Job: python-black 2026-08-25 17:43:28.292444 | Pipeline: check 2026-08-25 17:43:28.292468 | Executor: 521e9411259a 2026-08-25 17:43:28.292489 | Triggered by: https://github.com/osism/python-osism/pull/2622 2026-08-25 17:43:28.292512 | Event ID: 6db89680-a0ac-11f1-824f-39a4bced75a5 2026-08-25 17:43:28.297279 | 2026-08-25 17:43:28.297381 | LOOP [emit-job-header : Print node information] 2026-08-25 17:43:28.518698 | debian-bookworm | ok: 2026-08-25 17:43:28.518935 | debian-bookworm | # Node Information 2026-08-25 17:43:28.518974 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-25 17:43:28.518996 | debian-bookworm | Hostname: debian 2026-08-25 17:43:28.519015 | debian-bookworm | Username: zuul 2026-08-25 17:43:28.519056 | debian-bookworm | Distro: Debian 12.15 2026-08-25 17:43:28.519076 | debian-bookworm | Provider: regiocloud-a 2026-08-25 17:43:28.519094 | debian-bookworm | Region: 2026-08-25 17:43:28.519112 | debian-bookworm | Label: debian-bookworm 2026-08-25 17:43:28.519129 | debian-bookworm | Product Name: OpenStack Nova 2026-08-25 17:43:28.519145 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe15:8f93 2026-08-25 17:43:28.538298 | 2026-08-25 17:43:28.538411 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-25 17:43:29.160828 | debian-bookworm -> localhost | changed 2026-08-25 17:43:29.167960 | 2026-08-25 17:43:29.168092 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-25 17:43:30.740144 | debian-bookworm -> localhost | changed 2026-08-25 17:43:30.759168 | 2026-08-25 17:43:30.759294 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-25 17:43:31.442797 | debian-bookworm -> localhost | ok 2026-08-25 17:43:31.448977 | 2026-08-25 17:43:31.449088 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-25 17:43:31.488525 | debian-bookworm | ok 2026-08-25 17:43:31.515739 | debian-bookworm | included: /var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-25 17:43:31.532866 | 2026-08-25 17:43:31.532974 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-25 17:43:33.488666 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-25 17:43:33.489122 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/2e0dcfbb689b41059ee8a497ed85a02c_id_rsa 2026-08-25 17:43:33.489177 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/2e0dcfbb689b41059ee8a497ed85a02c_id_rsa.pub 2026-08-25 17:43:33.489202 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-25 17:43:33.489224 | debian-bookworm -> localhost | SHA256:DmU1CfCtlqT/lUJ8H+403G1zHTzjPHySzL9G8FcSWgU zuul-build-sshkey 2026-08-25 17:43:33.489244 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-25 17:43:33.489272 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-25 17:43:33.489366 | debian-bookworm -> localhost | | ....o. Eo.| 2026-08-25 17:43:33.489394 | debian-bookworm -> localhost | | . o.. o | 2026-08-25 17:43:33.489414 | debian-bookworm -> localhost | | = . o . | 2026-08-25 17:43:33.489433 | debian-bookworm -> localhost | | = + ..o .| 2026-08-25 17:43:33.489450 | debian-bookworm -> localhost | | o S o . +*.| 2026-08-25 17:43:33.489471 | debian-bookworm -> localhost | | = . . B+*B| 2026-08-25 17:43:33.489488 | debian-bookworm -> localhost | | o . o %*O| 2026-08-25 17:43:33.489597 | debian-bookworm -> localhost | | . o o *=| 2026-08-25 17:43:33.489626 | debian-bookworm -> localhost | | . o.o| 2026-08-25 17:43:33.489646 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-25 17:43:33.489700 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.154369 2026-08-25 17:43:33.500721 | 2026-08-25 17:43:33.500880 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-25 17:43:33.540063 | debian-bookworm | ok 2026-08-25 17:43:33.566498 | debian-bookworm | included: /var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-25 17:43:33.593975 | 2026-08-25 17:43:33.596956 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-25 17:43:33.636026 | debian-bookworm | skipping: Conditional result was False 2026-08-25 17:43:33.642495 | 2026-08-25 17:43:33.642581 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-25 17:43:34.350011 | debian-bookworm | changed 2026-08-25 17:43:34.355768 | 2026-08-25 17:43:34.355867 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-25 17:43:34.606695 | debian-bookworm | ok 2026-08-25 17:43:34.612233 | 2026-08-25 17:43:34.612332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-25 17:43:35.340700 | debian-bookworm | changed 2026-08-25 17:43:35.347524 | 2026-08-25 17:43:35.347629 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-25 17:43:36.004112 | debian-bookworm | changed 2026-08-25 17:43:36.009764 | 2026-08-25 17:43:36.009923 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-25 17:43:36.033067 | debian-bookworm | skipping: Conditional result was False 2026-08-25 17:43:36.039370 | 2026-08-25 17:43:36.039467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-25 17:43:36.515838 | debian-bookworm -> localhost | changed 2026-08-25 17:43:36.526667 | 2026-08-25 17:43:36.526766 | TASK [add-build-sshkey : Add back temp key] 2026-08-25 17:43:37.036440 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/2e0dcfbb689b41059ee8a497ed85a02c_id_rsa (zuul-build-sshkey) 2026-08-25 17:43:37.036630 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027129 2026-08-25 17:43:37.042749 | 2026-08-25 17:43:37.042997 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-25 17:43:37.417797 | debian-bookworm | ok 2026-08-25 17:43:37.431337 | 2026-08-25 17:43:37.431456 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-25 17:43:37.487743 | debian-bookworm | skipping: Conditional result was False 2026-08-25 17:43:37.506185 | 2026-08-25 17:43:37.506304 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-25 17:43:37.996557 | debian-bookworm | ok 2026-08-25 17:43:38.013819 | 2026-08-25 17:43:38.013944 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-25 17:43:38.054450 | debian-bookworm | ok 2026-08-25 17:43:38.059919 | 2026-08-25 17:43:38.060059 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-25 17:43:38.625635 | debian-bookworm -> localhost | ok 2026-08-25 17:43:38.633116 | 2026-08-25 17:43:38.633223 | TASK [validate-host : Collect information about the host] 2026-08-25 17:43:39.987558 | debian-bookworm | ok 2026-08-25 17:43:40.031474 | 2026-08-25 17:43:40.031588 | TASK [validate-host : Sanitize hostname] 2026-08-25 17:43:40.213731 | debian-bookworm | ok 2026-08-25 17:43:40.223551 | 2026-08-25 17:43:40.223664 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-25 17:43:41.492989 | debian-bookworm -> localhost | changed 2026-08-25 17:43:41.498198 | 2026-08-25 17:43:41.498285 | TASK [validate-host : Collect information about zuul worker] 2026-08-25 17:43:41.911944 | debian-bookworm | ok 2026-08-25 17:43:41.915785 | 2026-08-25 17:43:41.915870 | TASK [validate-host : Write out all zuul information for each host] 2026-08-25 17:43:43.283750 | debian-bookworm -> localhost | changed 2026-08-25 17:43:43.292373 | 2026-08-25 17:43:43.292470 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-25 17:43:43.615753 | debian-bookworm | ok 2026-08-25 17:43:43.621288 | 2026-08-25 17:43:43.621400 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-25 17:43:46.936755 | debian-bookworm | changed: 2026-08-25 17:43:46.936997 | debian-bookworm | cd+++++++++ src/ 2026-08-25 17:43:46.937116 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-25 17:43:46.937144 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-25 17:43:46.937166 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-25 17:43:46.937187 | debian-bookworm | Containerfile 2026-08-25 17:43:46.937319 | debian-bookworm | Containerfile 2026-08-25 17:43:46.965734 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/logs" 2026-08-25 17:45:01.076218 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/artifacts" 2026-08-25 17:45:01.352903 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2e0dcfbb689b41059ee8a497ed85a02c/work/docs" 2026-08-25 17:45:01.376526 | 2026-08-25 17:45:01.376707 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-25 17:45:02.283176 | debian-bookworm | changed: 2026-08-25 17:45:02.287383 | debian-bookworm | .d..t...... ./ 2026-08-25 17:45:02.287455 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-25 17:45:02.287483 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-25 17:45:02.287507 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-25 17:45:02.287530 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-25 17:45:02.287552 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-25 17:45:02.287599 | debian-bookworm | changed: All items complete 2026-08-25 17:45:02.287626 | 2026-08-25 17:45:02.888292 | debian-bookworm | changed: .d..t...... ./ 2026-08-25 17:45:03.485456 | debian-bookworm | changed: .d..t...... ./ 2026-08-25 17:45:03.501834 | 2026-08-25 17:45:03.502041 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-25 17:45:03.858218 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006232 2026-08-25 17:45:04.163857 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009781 2026-08-25 17:45:04.172678 | 2026-08-25 17:45:04.172787 | PLAY RECAP 2026-08-25 17:45:04.172839 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-25 17:45:04.172864 | 2026-08-25 17:45:04.308401 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-25 17:45:04.309354 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-25 17:45:05.114019 | 2026-08-25 17:45:05.114213 | PLAY [Base post] 2026-08-25 17:45:05.129200 | 2026-08-25 17:45:05.129365 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-25 17:45:05.698540 | debian-bookworm | changed 2026-08-25 17:45:05.710359 | 2026-08-25 17:45:05.710772 | PLAY RECAP 2026-08-25 17:45:05.710997 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-25 17:45:05.711369 | 2026-08-25 17:45:05.892124 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-25 17:45:05.893022 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-25 17:45:06.753091 | 2026-08-25 17:45:06.753270 | PLAY [Base post-logs] 2026-08-25 17:45:06.764461 | 2026-08-25 17:45:06.764618 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-25 17:45:07.258638 | localhost | changed 2026-08-25 17:45:07.269827 | 2026-08-25 17:45:07.269999 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-25 17:45:07.296552 | localhost | ok 2026-08-25 17:45:07.299697 | 2026-08-25 17:45:07.299803 | TASK [Set zuul-log-path fact] 2026-08-25 17:45:07.325395 | localhost | ok 2026-08-25 17:45:07.335731 | 2026-08-25 17:45:07.335876 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-25 17:45:07.364491 | localhost | ok 2026-08-25 17:45:07.372266 | 2026-08-25 17:45:07.372504 | TASK [upload-logs : Create log directories] 2026-08-25 17:45:07.988911 | localhost | changed 2026-08-25 17:45:07.991919 | 2026-08-25 17:45:07.992075 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-25 17:45:08.572868 | localhost -> localhost | ok: Runtime: 0:00:00.011794 2026-08-25 17:45:08.577157 | 2026-08-25 17:45:08.577283 | TASK [upload-logs : Upload logs to log server] 2026-08-25 17:45:09.224422 | localhost | Output suppressed because no_log was given 2026-08-25 17:45:09.226366 | 2026-08-25 17:45:09.226482 | LOOP [upload-logs : Compress console log and json output] 2026-08-25 17:45:09.298540 | localhost | skipping: Conditional result was False 2026-08-25 17:45:09.301613 | localhost | skipping: Conditional result was False 2026-08-25 17:45:09.318647 | 2026-08-25 17:45:09.318808 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-25 17:45:09.373715 | localhost | skipping: Conditional result was False 2026-08-25 17:45:09.374144 | 2026-08-25 17:45:09.379709 | localhost | skipping: Conditional result was False 2026-08-25 17:45:09.393568 | 2026-08-25 17:45:09.393787 | LOOP [upload-logs : Upload console log and json output]