2025-09-23 06:51:32.379295 | Job console starting 2025-09-23 06:51:32.398777 | Updating git repos 2025-09-23 06:51:32.425911 | Cloning repos into workspace 2025-09-23 06:51:32.497447 | Restoring repo states 2025-09-23 06:51:32.506246 | Merging changes 2025-09-23 06:51:33.009276 | Checking out repos 2025-09-23 06:51:33.061101 | Preparing playbooks 2025-09-23 06:51:33.701049 | Running Ansible setup 2025-09-23 06:51:38.176227 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 06:51:38.957411 | 2025-09-23 06:51:38.957581 | PLAY [Base pre] 2025-09-23 06:51:38.977277 | 2025-09-23 06:51:38.977422 | TASK [Setup log path fact] 2025-09-23 06:51:39.008942 | debian-bookworm | ok 2025-09-23 06:51:39.026933 | 2025-09-23 06:51:39.027090 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 06:51:39.056850 | debian-bookworm | ok 2025-09-23 06:51:39.066541 | 2025-09-23 06:51:39.066654 | TASK [emit-job-header : Print job information] 2025-09-23 06:51:39.106435 | # Job Information 2025-09-23 06:51:39.106625 | Ansible Version: 2.16.14 2025-09-23 06:51:39.106661 | Job: python-black 2025-09-23 06:51:39.106695 | Pipeline: check 2025-09-23 06:51:39.106719 | Executor: 521e9411259a 2025-09-23 06:51:39.106740 | Triggered by: https://github.com/osism/testbed/pull/2225 2025-09-23 06:51:39.106762 | Event ID: a33f8910-9849-11f0-8bd1-b9afc95b7106 2025-09-23 06:51:39.111677 | 2025-09-23 06:51:39.111784 | LOOP [emit-job-header : Print node information] 2025-09-23 06:51:39.237965 | debian-bookworm | ok: 2025-09-23 06:51:39.238230 | debian-bookworm | # Node Information 2025-09-23 06:51:39.238271 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 06:51:39.238296 | debian-bookworm | Hostname: debian 2025-09-23 06:51:39.238318 | debian-bookworm | Username: zuul 2025-09-23 06:51:39.238339 | debian-bookworm | Distro: Debian 12.12 2025-09-23 06:51:39.238363 | debian-bookworm | Provider: regiocloud-a 2025-09-23 06:51:39.238384 | debian-bookworm | Region: 2025-09-23 06:51:39.238405 | debian-bookworm | Label: debian-bookworm 2025-09-23 06:51:39.238424 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 06:51:39.238444 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe73:d4c0 2025-09-23 06:51:39.259022 | 2025-09-23 06:51:39.259151 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 06:51:39.751789 | debian-bookworm -> localhost | changed 2025-09-23 06:51:39.770005 | 2025-09-23 06:51:39.770218 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 06:51:40.906628 | debian-bookworm -> localhost | changed 2025-09-23 06:51:40.920069 | 2025-09-23 06:51:40.920208 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 06:51:41.478136 | debian-bookworm -> localhost | ok 2025-09-23 06:51:41.485722 | 2025-09-23 06:51:41.485854 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 06:51:41.525391 | debian-bookworm | ok 2025-09-23 06:51:41.560806 | debian-bookworm | included: /var/lib/zuul/builds/ee36da8d8d59461f89976930e3f0df83/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 06:51:41.576869 | 2025-09-23 06:51:41.576998 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 06:51:44.394918 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 06:51:44.395116 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee36da8d8d59461f89976930e3f0df83/work/ee36da8d8d59461f89976930e3f0df83_id_rsa 2025-09-23 06:51:44.395151 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee36da8d8d59461f89976930e3f0df83/work/ee36da8d8d59461f89976930e3f0df83_id_rsa.pub 2025-09-23 06:51:44.395173 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 06:51:44.395193 | debian-bookworm -> localhost | SHA256:W3SAD/slkq69kemm/9pt4WaPQltCJiKXfV21xzMeEKY zuul-build-sshkey 2025-09-23 06:51:44.395211 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 06:51:44.395238 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 06:51:44.395256 | debian-bookworm -> localhost | | .. +...| 2025-09-23 06:51:44.395273 | debian-bookworm -> localhost | | o .o o..| 2025-09-23 06:51:44.395289 | debian-bookworm -> localhost | | o =.E.. =o| 2025-09-23 06:51:44.395305 | debian-bookworm -> localhost | | . + *.*.o . =| 2025-09-23 06:51:44.395322 | debian-bookworm -> localhost | | o oSB.o . | 2025-09-23 06:51:44.395342 | debian-bookworm -> localhost | | .=+ o | 2025-09-23 06:51:44.395358 | debian-bookworm -> localhost | | o=. = . | 2025-09-23 06:51:44.395374 | debian-bookworm -> localhost | | ..ooo.=. | 2025-09-23 06:51:44.395390 | debian-bookworm -> localhost | | .+=+o=o.. | 2025-09-23 06:51:44.395407 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 06:51:44.395451 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.198757 2025-09-23 06:51:44.400668 | 2025-09-23 06:51:44.400744 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 06:51:44.437814 | debian-bookworm | ok 2025-09-23 06:51:44.451527 | debian-bookworm | included: /var/lib/zuul/builds/ee36da8d8d59461f89976930e3f0df83/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 06:51:44.463381 | 2025-09-23 06:51:44.463500 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 06:51:44.479327 | debian-bookworm | skipping: Conditional result was False 2025-09-23 06:51:44.484714 | 2025-09-23 06:51:44.484790 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 06:51:45.165980 | debian-bookworm | changed 2025-09-23 06:51:45.170313 | 2025-09-23 06:51:45.170388 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 06:51:45.437957 | debian-bookworm | ok 2025-09-23 06:51:45.442241 | 2025-09-23 06:51:45.442313 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 06:51:46.197320 | debian-bookworm | changed 2025-09-23 06:51:46.205183 | 2025-09-23 06:51:46.205280 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 06:51:46.916877 | debian-bookworm | changed 2025-09-23 06:51:46.922087 | 2025-09-23 06:51:46.922185 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 06:51:46.935371 | debian-bookworm | skipping: Conditional result was False 2025-09-23 06:51:46.942240 | 2025-09-23 06:51:46.942355 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 06:51:47.529713 | debian-bookworm -> localhost | changed 2025-09-23 06:51:47.544934 | 2025-09-23 06:51:47.545031 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 06:51:47.989539 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ee36da8d8d59461f89976930e3f0df83/work/ee36da8d8d59461f89976930e3f0df83_id_rsa (zuul-build-sshkey) 2025-09-23 06:51:47.989747 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017353 2025-09-23 06:51:47.998841 | 2025-09-23 06:51:47.999017 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 06:51:48.441449 | debian-bookworm | ok 2025-09-23 06:51:48.447664 | 2025-09-23 06:51:48.447762 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 06:51:48.471172 | debian-bookworm | skipping: Conditional result was False 2025-09-23 06:51:48.480797 | 2025-09-23 06:51:48.480878 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 06:51:48.920118 | debian-bookworm | ok 2025-09-23 06:51:48.931381 | 2025-09-23 06:51:48.931536 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 06:51:48.960038 | debian-bookworm | ok 2025-09-23 06:51:48.965568 | 2025-09-23 06:51:48.965733 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 06:51:49.275357 | debian-bookworm -> localhost | ok 2025-09-23 06:51:49.281927 | 2025-09-23 06:51:49.282030 | TASK [validate-host : Collect information about the host] 2025-09-23 06:51:50.481345 | debian-bookworm | ok 2025-09-23 06:51:50.492204 | 2025-09-23 06:51:50.492315 | TASK [validate-host : Sanitize hostname] 2025-09-23 06:51:50.623262 | debian-bookworm | ok 2025-09-23 06:51:50.673971 | 2025-09-23 06:51:50.674105 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 06:51:51.217988 | debian-bookworm -> localhost | changed 2025-09-23 06:51:51.230178 | 2025-09-23 06:51:51.230343 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 06:51:51.652338 | debian-bookworm | ok 2025-09-23 06:51:51.658388 | 2025-09-23 06:51:51.658555 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 06:51:52.232797 | debian-bookworm -> localhost | changed 2025-09-23 06:51:52.250637 | 2025-09-23 06:51:52.250758 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 06:51:52.521723 | debian-bookworm | ok 2025-09-23 06:51:52.527608 | 2025-09-23 06:51:52.527718 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 06:51:53.731846 | debian-bookworm | changed: 2025-09-23 06:51:53.732169 | debian-bookworm | cd+++++++++ src/ 2025-09-23 06:51:53.732232 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 06:51:53.732276 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 06:51:53.732313 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-23 06:51:53.732349 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007905 2025-09-23 06:52:18.871337 | 2025-09-23 06:52:18.871498 | TASK [upload-logs : Upload logs to log server] 2025-09-23 06:52:19.421599 | localhost | Output suppressed because no_log was given 2025-09-23 06:52:19.425726 | 2025-09-23 06:52:19.425918 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 06:52:19.484258 | localhost | skipping: Conditional result was False 2025-09-23 06:52:19.490086 | localhost | skipping: Conditional result was False 2025-09-23 06:52:19.499029 | 2025-09-23 06:52:19.499245 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 06:52:19.550111 | localhost | skipping: Conditional result was False 2025-09-23 06:52:19.550753 | 2025-09-23 06:52:19.552721 | localhost | skipping: Conditional result was False 2025-09-23 06:52:19.563370 | 2025-09-23 06:52:19.563515 | LOOP [upload-logs : Upload console log and json output]