2025-09-30 23:00:26.581798 | Job console starting 2025-09-30 23:00:26.601500 | Updating git repos 2025-09-30 23:00:26.685149 | Cloning repos into workspace 2025-09-30 23:00:26.792687 | Restoring repo states 2025-09-30 23:00:26.810403 | Merging changes 2025-09-30 23:00:27.306363 | Checking out repos 2025-09-30 23:00:27.376868 | Preparing playbooks 2025-09-30 23:00:28.686281 | Running Ansible setup 2025-09-30 23:00:34.050055 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-30 23:00:35.078078 | 2025-09-30 23:00:35.078194 | PLAY [Base pre] 2025-09-30 23:00:35.112061 | 2025-09-30 23:00:35.112173 | TASK [Setup log path fact] 2025-09-30 23:00:35.140266 | debian-bookworm | ok 2025-09-30 23:00:35.166164 | 2025-09-30 23:00:35.166292 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 23:00:35.215153 | debian-bookworm | ok 2025-09-30 23:00:35.251826 | 2025-09-30 23:00:35.251937 | TASK [emit-job-header : Print job information] 2025-09-30 23:00:35.310442 | # Job Information 2025-09-30 23:00:35.310596 | Ansible Version: 2.16.14 2025-09-30 23:00:35.310632 | Job: python-black 2025-09-30 23:00:35.310664 | Pipeline: check 2025-09-30 23:00:35.310688 | Executor: 521e9411259a 2025-09-30 23:00:35.310709 | Triggered by: https://github.com/osism/python-osism/pull/1732 2025-09-30 23:00:35.310731 | Event ID: 3a6f7d10-9e51-11f0-97c6-c0c8472c555b 2025-09-30 23:00:35.315498 | 2025-09-30 23:00:35.315591 | LOOP [emit-job-header : Print node information] 2025-09-30 23:00:35.504612 | debian-bookworm | ok: 2025-09-30 23:00:35.504774 | debian-bookworm | # Node Information 2025-09-30 23:00:35.504807 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-30 23:00:35.504833 | debian-bookworm | Hostname: debian 2025-09-30 23:00:35.504855 | debian-bookworm | Username: zuul 2025-09-30 23:00:35.504875 | debian-bookworm | Distro: Debian 12.12 2025-09-30 23:00:35.504899 | debian-bookworm | Provider: regiocloud-a 2025-09-30 23:00:35.504920 | debian-bookworm | Region: 2025-09-30 23:00:35.504941 | debian-bookworm | Label: debian-bookworm 2025-09-30 23:00:35.504961 | debian-bookworm | Product Name: OpenStack Nova 2025-09-30 23:00:35.504980 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee7:2d8 2025-09-30 23:00:35.522789 | 2025-09-30 23:00:35.522915 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-30 23:00:36.250769 | debian-bookworm -> localhost | changed 2025-09-30 23:00:36.256550 | 2025-09-30 23:00:36.256636 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-30 23:00:37.849610 | debian-bookworm -> localhost | changed 2025-09-30 23:00:37.858148 | 2025-09-30 23:00:37.858235 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-30 23:00:38.322879 | debian-bookworm -> localhost | ok 2025-09-30 23:00:38.329396 | 2025-09-30 23:00:38.329514 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-30 23:00:38.348508 | debian-bookworm | ok 2025-09-30 23:00:38.393271 | debian-bookworm | included: /var/lib/zuul/builds/256e747a215c43238852dafd743a245d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-30 23:00:38.420074 | 2025-09-30 23:00:38.420180 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-30 23:00:40.354526 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-30 23:00:40.354691 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/256e747a215c43238852dafd743a245d/work/256e747a215c43238852dafd743a245d_id_rsa 2025-09-30 23:00:40.354722 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/256e747a215c43238852dafd743a245d/work/256e747a215c43238852dafd743a245d_id_rsa.pub 2025-09-30 23:00:40.354744 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-30 23:00:40.354763 | debian-bookworm -> localhost | SHA256:bd1oG3oTwvOVXBU2lrV2uh16H1LLnTY9RhPWoSHkP0s zuul-build-sshkey 2025-09-30 23:00:40.354781 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-30 23:00:40.354807 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-30 23:00:40.354826 | debian-bookworm -> localhost | | .o . **| 2025-09-30 23:00:40.354877 | debian-bookworm -> localhost | | . . =.*| 2025-09-30 23:00:40.354894 | debian-bookworm -> localhost | | . . =+| 2025-09-30 23:00:40.354910 | debian-bookworm -> localhost | | o ..+o+o| 2025-09-30 23:00:40.354926 | debian-bookworm -> localhost | | S * *E*= | 2025-09-30 23:00:40.354946 | debian-bookworm -> localhost | | . *.=BoB| 2025-09-30 23:00:40.354964 | debian-bookworm -> localhost | | . =+.@+| 2025-09-30 23:00:40.354980 | debian-bookworm -> localhost | | . .= =| 2025-09-30 23:00:40.354997 | debian-bookworm -> localhost | | .| 2025-09-30 23:00:40.355014 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-30 23:00:40.355059 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.115525 2025-09-30 23:00:40.360035 | 2025-09-30 23:00:40.360112 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-30 23:00:40.376039 | debian-bookworm | ok 2025-09-30 23:00:40.385744 | debian-bookworm | included: /var/lib/zuul/builds/256e747a215c43238852dafd743a245d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-30 23:00:40.394891 | 2025-09-30 23:00:40.394977 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-30 23:00:40.407382 | debian-bookworm | skipping: Conditional result was False 2025-09-30 23:00:40.413457 | 2025-09-30 23:00:40.413548 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-30 23:00:41.055209 | debian-bookworm | changed 2025-09-30 23:00:41.060650 | 2025-09-30 23:00:41.060744 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-30 23:00:41.307428 | debian-bookworm | ok 2025-09-30 23:00:41.313418 | 2025-09-30 23:00:41.313515 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-30 23:00:41.910589 | debian-bookworm | changed 2025-09-30 23:00:41.933015 | 2025-09-30 23:00:41.933127 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-30 23:00:42.584701 | debian-bookworm | changed 2025-09-30 23:00:42.590394 | 2025-09-30 23:00:42.590496 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-30 23:00:42.634178 | debian-bookworm | skipping: Conditional result was False 2025-09-30 23:00:42.639908 | 2025-09-30 23:00:42.639995 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-30 23:00:43.153760 | debian-bookworm -> localhost | changed 2025-09-30 23:00:43.167565 | 2025-09-30 23:00:43.167664 | TASK [add-build-sshkey : Add back temp key] 2025-09-30 23:00:43.500959 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/256e747a215c43238852dafd743a245d/work/256e747a215c43238852dafd743a245d_id_rsa (zuul-build-sshkey) 2025-09-30 23:00:43.501163 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015656 2025-09-30 23:00:43.508424 | 2025-09-30 23:00:43.508525 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-30 23:00:44.022021 | debian-bookworm | ok 2025-09-30 23:00:44.027089 | 2025-09-30 23:00:44.027193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-30 23:00:44.075920 | debian-bookworm | skipping: Conditional result was False 2025-09-30 23:00:44.086716 | 2025-09-30 23:00:44.086823 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-30 23:00:44.509885 | debian-bookworm | ok 2025-09-30 23:00:44.521496 | 2025-09-30 23:00:44.521604 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-30 23:00:44.561091 | debian-bookworm | ok 2025-09-30 23:00:44.566632 | 2025-09-30 23:00:44.566731 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-30 23:00:44.953344 | debian-bookworm -> localhost | ok 2025-09-30 23:00:44.960050 | 2025-09-30 23:00:44.968155 | TASK [validate-host : Collect information about the host] 2025-09-30 23:00:46.032128 | debian-bookworm | ok 2025-09-30 23:00:46.052540 | 2025-09-30 23:00:46.052646 | TASK [validate-host : Sanitize hostname] 2025-09-30 23:00:46.212495 | debian-bookworm | ok 2025-09-30 23:00:46.243439 | 2025-09-30 23:00:46.243652 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-30 23:00:47.078246 | debian-bookworm -> localhost | changed 2025-09-30 23:00:47.083634 | 2025-09-30 23:00:47.083727 | TASK [validate-host : Collect information about zuul worker] 2025-09-30 23:00:47.532830 | debian-bookworm | ok 2025-09-30 23:00:47.537717 | 2025-09-30 23:00:47.537802 | TASK [validate-host : Write out all zuul information for each host] 2025-09-30 23:00:48.097274 | debian-bookworm -> localhost | changed 2025-09-30 23:00:48.105055 | 2025-09-30 23:00:48.105138 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-30 23:00:48.361140 | debian-bookworm | ok 2025-09-30 23:00:48.369305 | 2025-09-30 23:00:48.370641 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-30 23:00:49.630656 | debian-bookworm | changed: 2025-09-30 23:00:49.630822 | debian-bookworm | cd+++++++++ src/ 2025-09-30 23:00:49.630872 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-30 23:00:49.630896 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-30 23:00:49.630918 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-30 23:00:49.630938 | debian-bookworm | Containerfile 2025-09-30 23:00:49.631051 | debian-bookworm | Containerfile 2025-09-30 23:00:49.686850 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006772 2025-09-30 23:01:15.079388 | 2025-09-30 23:01:15.079551 | TASK [upload-logs : Upload logs to log server] 2025-09-30 23:01:15.648221 | localhost | Output suppressed because no_log was given 2025-09-30 23:01:15.650992 | 2025-09-30 23:01:15.651135 | LOOP [upload-logs : Compress console log and json output] 2025-09-30 23:01:15.704003 | localhost | skipping: Conditional result was False 2025-09-30 23:01:15.709562 | localhost | skipping: Conditional result was False 2025-09-30 23:01:15.721509 | 2025-09-30 23:01:15.721717 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-30 23:01:15.766554 | localhost | skipping: Conditional result was False 2025-09-30 23:01:15.767018 | 2025-09-30 23:01:15.770854 | localhost | skipping: Conditional result was False 2025-09-30 23:01:15.784618 | 2025-09-30 23:01:15.784858 | LOOP [upload-logs : Upload console log and json output]