2025-10-31 23:35:40.424055 | Job console starting 2025-10-31 23:35:40.436932 | Updating git repos 2025-10-31 23:35:40.471250 | Cloning repos into workspace 2025-10-31 23:35:40.552352 | Restoring repo states 2025-10-31 23:35:40.562507 | Merging changes 2025-10-31 23:35:41.054188 | Checking out repos 2025-10-31 23:35:41.103281 | Preparing playbooks 2025-10-31 23:35:41.769618 | Running Ansible setup 2025-10-31 23:35:47.232277 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-31 23:35:48.084258 | 2025-10-31 23:35:48.084482 | PLAY [Base pre] 2025-10-31 23:35:48.100790 | 2025-10-31 23:35:48.100933 | TASK [Setup log path fact] 2025-10-31 23:35:48.130017 | debian-bookworm | ok 2025-10-31 23:35:48.145019 | 2025-10-31 23:35:48.145162 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-31 23:35:48.174903 | debian-bookworm | ok 2025-10-31 23:35:48.194630 | 2025-10-31 23:35:48.194793 | TASK [emit-job-header : Print job information] 2025-10-31 23:35:48.235387 | # Job Information 2025-10-31 23:35:48.235577 | Ansible Version: 2.16.14 2025-10-31 23:35:48.235613 | Job: python-black 2025-10-31 23:35:48.235646 | Pipeline: check 2025-10-31 23:35:48.235669 | Executor: 521e9411259a 2025-10-31 23:35:48.235690 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-10-31 23:35:48.235713 | Event ID: 49d11b00-b6b2-11f0-8723-12e2770262db 2025-10-31 23:35:48.240531 | 2025-10-31 23:35:48.240648 | LOOP [emit-job-header : Print node information] 2025-10-31 23:35:48.346395 | debian-bookworm | ok: 2025-10-31 23:35:48.346788 | debian-bookworm | # Node Information 2025-10-31 23:35:48.346853 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-31 23:35:48.346881 | debian-bookworm | Hostname: debian 2025-10-31 23:35:48.346903 | debian-bookworm | Username: zuul 2025-10-31 23:35:48.346924 | debian-bookworm | Distro: Debian 12.12 2025-10-31 23:35:48.346948 | debian-bookworm | Provider: regiocloud-a 2025-10-31 23:35:48.346969 | debian-bookworm | Region: 2025-10-31 23:35:48.346990 | debian-bookworm | Label: debian-bookworm 2025-10-31 23:35:48.347010 | debian-bookworm | Product Name: OpenStack Nova 2025-10-31 23:35:48.347029 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:b485 2025-10-31 23:35:48.367313 | 2025-10-31 23:35:48.367441 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-31 23:35:48.856790 | debian-bookworm -> localhost | changed 2025-10-31 23:35:48.864056 | 2025-10-31 23:35:48.864176 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-31 23:35:49.850932 | debian-bookworm -> localhost | changed 2025-10-31 23:35:49.861619 | 2025-10-31 23:35:49.861725 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-31 23:35:50.272567 | debian-bookworm -> localhost | ok 2025-10-31 23:35:50.278261 | 2025-10-31 23:35:50.278355 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-31 23:35:50.295452 | debian-bookworm | ok 2025-10-31 23:35:50.311197 | debian-bookworm | included: /var/lib/zuul/builds/c1de6c01dbe345beb5f64c0d61c24637/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-31 23:35:50.316769 | 2025-10-31 23:35:50.316847 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-31 23:35:51.611861 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-31 23:35:51.612312 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c1de6c01dbe345beb5f64c0d61c24637/work/c1de6c01dbe345beb5f64c0d61c24637_id_rsa 2025-10-31 23:35:51.612424 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c1de6c01dbe345beb5f64c0d61c24637/work/c1de6c01dbe345beb5f64c0d61c24637_id_rsa.pub 2025-10-31 23:35:51.612499 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-31 23:35:51.612588 | debian-bookworm -> localhost | SHA256:m6+HEFH8f76T277T9yAqy5pirjxgKyndc/nZzxKt6ZU zuul-build-sshkey 2025-10-31 23:35:51.612653 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-31 23:35:51.612736 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-31 23:35:51.612800 | debian-bookworm -> localhost | | o. | 2025-10-31 23:35:51.612862 | debian-bookworm -> localhost | | . . | 2025-10-31 23:35:51.612919 | debian-bookworm -> localhost | | . . | 2025-10-31 23:35:51.612974 | debian-bookworm -> localhost | | . . | 2025-10-31 23:35:51.613028 | debian-bookworm -> localhost | | .S o | 2025-10-31 23:35:51.613141 | debian-bookworm -> localhost | |.. . o. o.. | 2025-10-31 23:35:51.613218 | debian-bookworm -> localhost | |.+.. oo. +Eo...| 2025-10-31 23:35:51.613290 | debian-bookworm -> localhost | |+oo = ooo+=+ .++o| 2025-10-31 23:35:51.613352 | debian-bookworm -> localhost | |o o=.+oo**=oo o*O| 2025-10-31 23:35:51.613408 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-31 23:35:51.613572 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.842234 2025-10-31 23:35:51.625873 | 2025-10-31 23:35:51.625997 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-31 23:35:51.647056 | debian-bookworm | ok 2025-10-31 23:35:51.657679 | debian-bookworm | included: /var/lib/zuul/builds/c1de6c01dbe345beb5f64c0d61c24637/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-31 23:35:51.666019 | 2025-10-31 23:35:51.666094 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-31 23:35:51.688725 | debian-bookworm | skipping: Conditional result was False 2025-10-31 23:35:51.694718 | 2025-10-31 23:35:51.694803 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-31 23:35:52.326683 | debian-bookworm | changed 2025-10-31 23:35:52.335122 | 2025-10-31 23:35:52.335233 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-31 23:35:52.608871 | debian-bookworm | ok 2025-10-31 23:35:52.622020 | 2025-10-31 23:35:52.622146 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-31 23:35:53.259318 | debian-bookworm | changed 2025-10-31 23:35:53.265605 | 2025-10-31 23:35:53.265690 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-31 23:35:53.920094 | debian-bookworm | changed 2025-10-31 23:35:53.925752 | 2025-10-31 23:35:53.925845 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-31 23:35:53.958771 | debian-bookworm | skipping: Conditional result was False 2025-10-31 23:35:53.966616 | 2025-10-31 23:35:53.966715 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-31 23:35:54.343445 | debian-bookworm -> localhost | changed 2025-10-31 23:35:54.354050 | 2025-10-31 23:35:54.354143 | TASK [add-build-sshkey : Add back temp key] 2025-10-31 23:35:54.643278 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c1de6c01dbe345beb5f64c0d61c24637/work/c1de6c01dbe345beb5f64c0d61c24637_id_rsa (zuul-build-sshkey) 2025-10-31 23:35:54.643479 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008792 2025-10-31 23:35:54.651179 | 2025-10-31 23:35:54.651280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-31 23:35:55.035155 | debian-bookworm | ok 2025-10-31 23:35:55.039961 | 2025-10-31 23:35:55.040044 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-31 23:35:55.073564 | debian-bookworm | skipping: Conditional result was False 2025-10-31 23:35:55.092921 | 2025-10-31 23:35:55.093019 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-31 23:35:55.493169 | debian-bookworm | ok 2025-10-31 23:35:55.509322 | 2025-10-31 23:35:55.509442 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-31 23:35:55.554638 | debian-bookworm | ok 2025-10-31 23:35:55.562726 | 2025-10-31 23:35:55.562861 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-31 23:35:55.820102 | debian-bookworm -> localhost | ok 2025-10-31 23:35:55.826158 | 2025-10-31 23:35:55.826239 | TASK [validate-host : Collect information about the host] 2025-10-31 23:35:56.885973 | debian-bookworm | ok 2025-10-31 23:35:56.896728 | 2025-10-31 23:35:56.896827 | TASK [validate-host : Sanitize hostname] 2025-10-31 23:35:56.985938 | debian-bookworm | ok 2025-10-31 23:35:57.015392 | 2025-10-31 23:35:57.015491 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-31 23:35:57.539064 | debian-bookworm -> localhost | changed 2025-10-31 23:35:57.544441 | 2025-10-31 23:35:57.544527 | TASK [validate-host : Collect information about zuul worker] 2025-10-31 23:35:57.998872 | debian-bookworm | ok 2025-10-31 23:35:58.006634 | 2025-10-31 23:35:58.006758 | TASK [validate-host : Write out all zuul information for each host] 2025-10-31 23:35:58.599469 | debian-bookworm -> localhost | changed 2025-10-31 23:35:58.618762 | 2025-10-31 23:35:58.619018 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-31 23:35:58.902392 | debian-bookworm | ok 2025-10-31 23:35:58.911465 | 2025-10-31 23:35:58.911601 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-31 23:36:00.045822 | debian-bookworm | changed: 2025-10-31 23:36:00.046028 | debian-bookworm | cd+++++++++ src/ 2025-10-31 23:36:00.046063 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-31 23:36:00.046087 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-31 23:36:00.046109 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-10-31 23:36:00.046130 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006765 2025-10-31 23:36:25.460083 | 2025-10-31 23:36:25.460280 | TASK [upload-logs : Upload logs to log server] 2025-10-31 23:36:26.005090 | localhost | Output suppressed because no_log was given 2025-10-31 23:36:26.009023 | 2025-10-31 23:36:26.009198 | LOOP [upload-logs : Compress console log and json output] 2025-10-31 23:36:26.059770 | localhost | skipping: Conditional result was False 2025-10-31 23:36:26.064762 | localhost | skipping: Conditional result was False 2025-10-31 23:36:26.073483 | 2025-10-31 23:36:26.073723 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-31 23:36:26.119082 | localhost | skipping: Conditional result was False 2025-10-31 23:36:26.119691 | 2025-10-31 23:36:26.123136 | localhost | skipping: Conditional result was False 2025-10-31 23:36:26.136405 | 2025-10-31 23:36:26.136630 | LOOP [upload-logs : Upload console log and json output]