2025-07-18 03:12:53.957004 | Job console starting 2025-07-18 03:12:53.970248 | Updating git repos 2025-07-18 03:12:54.011862 | Cloning repos into workspace 2025-07-18 03:12:54.163433 | Restoring repo states 2025-07-18 03:12:54.186001 | Merging changes 2025-07-18 03:12:54.186024 | Checking out repos 2025-07-18 03:12:54.321830 | Preparing playbooks 2025-07-18 03:12:55.198426 | Running Ansible setup 2025-07-18 03:13:01.395496 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-18 03:13:03.033182 | 2025-07-18 03:13:03.033394 | PLAY [Base pre] 2025-07-18 03:13:03.085077 | 2025-07-18 03:13:03.085243 | TASK [Setup log path fact] 2025-07-18 03:13:03.123710 | debian-bookworm | ok 2025-07-18 03:13:03.153090 | 2025-07-18 03:13:03.153256 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-18 03:13:03.238213 | debian-bookworm | ok 2025-07-18 03:13:03.270584 | 2025-07-18 03:13:03.270734 | TASK [emit-job-header : Print job information] 2025-07-18 03:13:03.354050 | # Job Information 2025-07-18 03:13:03.354321 | Ansible Version: 2.16.14 2025-07-18 03:13:03.354362 | Job: python-black 2025-07-18 03:13:03.354399 | Pipeline: periodic-daily 2025-07-18 03:13:03.354427 | Executor: 521e9411259a 2025-07-18 03:13:03.354448 | Triggered by: https://github.com/osism/testbed 2025-07-18 03:13:03.354470 | Event ID: 0d7a871869274d398c8706b4bf5a57a6 2025-07-18 03:13:03.367509 | 2025-07-18 03:13:03.367650 | LOOP [emit-job-header : Print node information] 2025-07-18 03:13:03.526550 | debian-bookworm | ok: 2025-07-18 03:13:03.526876 | debian-bookworm | # Node Information 2025-07-18 03:13:03.526946 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-18 03:13:03.526975 | debian-bookworm | Hostname: debian 2025-07-18 03:13:03.526999 | debian-bookworm | Username: zuul 2025-07-18 03:13:03.527021 | debian-bookworm | Distro: Debian 12.11 2025-07-18 03:13:03.527045 | debian-bookworm | Provider: regiocloud-a 2025-07-18 03:13:03.527067 | debian-bookworm | Region: 2025-07-18 03:13:03.527088 | debian-bookworm | Label: debian-bookworm 2025-07-18 03:13:03.527107 | debian-bookworm | Product Name: OpenStack Nova 2025-07-18 03:13:03.527126 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe21:8392 2025-07-18 03:13:03.554644 | 2025-07-18 03:13:03.554789 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-18 03:13:04.514254 | debian-bookworm -> localhost | changed 2025-07-18 03:13:04.520057 | 2025-07-18 03:13:04.520143 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-18 03:13:06.029566 | debian-bookworm -> localhost | changed 2025-07-18 03:13:06.037923 | 2025-07-18 03:13:06.038008 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-18 03:13:06.280974 | debian-bookworm -> localhost | ok 2025-07-18 03:13:06.286184 | 2025-07-18 03:13:06.286276 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-18 03:13:06.302653 | debian-bookworm | ok 2025-07-18 03:13:06.323883 | debian-bookworm | included: /var/lib/zuul/builds/4cba55a8560b41dbac99bdaf3ac19aa0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-18 03:13:06.334668 | 2025-07-18 03:13:06.334756 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-18 03:13:08.317312 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-18 03:13:08.317473 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4cba55a8560b41dbac99bdaf3ac19aa0/work/4cba55a8560b41dbac99bdaf3ac19aa0_id_rsa 2025-07-18 03:13:08.317504 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4cba55a8560b41dbac99bdaf3ac19aa0/work/4cba55a8560b41dbac99bdaf3ac19aa0_id_rsa.pub 2025-07-18 03:13:08.317526 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-18 03:13:08.317545 | debian-bookworm -> localhost | SHA256:ojjxQGhw8LfY3fT4dbN6ySdJlAn4+mzwqV60878l564 zuul-build-sshkey 2025-07-18 03:13:08.317563 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-18 03:13:08.317589 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-18 03:13:08.317607 | debian-bookworm -> localhost | |o.. . | 2025-07-18 03:13:08.317625 | debian-bookworm -> localhost | |.+ . . | 2025-07-18 03:13:08.317641 | debian-bookworm -> localhost | |..o . . . . o | 2025-07-18 03:13:08.317657 | debian-bookworm -> localhost | |.. + o o o . + | 2025-07-18 03:13:08.317674 | debian-bookworm -> localhost | | + o o S ..o.o | 2025-07-18 03:13:08.317697 | debian-bookworm -> localhost | | = . . .oo o.o | 2025-07-18 03:13:08.317715 | debian-bookworm -> localhost | | o o .=++ooo| 2025-07-18 03:13:08.317732 | debian-bookworm -> localhost | | . .*+*+o| 2025-07-18 03:13:08.317750 | debian-bookworm -> localhost | | .oo..EB=| 2025-07-18 03:13:08.317766 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-18 03:13:08.317806 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.445774 2025-07-18 03:13:08.325454 | 2025-07-18 03:13:08.325540 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-18 03:13:08.365788 | debian-bookworm | ok 2025-07-18 03:13:08.376430 | debian-bookworm | included: /var/lib/zuul/builds/4cba55a8560b41dbac99bdaf3ac19aa0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-18 03:13:08.406600 | 2025-07-18 03:13:08.406785 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-18 03:13:08.440354 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:13:08.446607 | 2025-07-18 03:13:08.446700 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-18 03:13:09.052705 | debian-bookworm | changed 2025-07-18 03:13:09.057275 | 2025-07-18 03:13:09.057362 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-18 03:13:09.303523 | debian-bookworm | ok 2025-07-18 03:13:09.308848 | 2025-07-18 03:13:09.308950 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-18 03:13:09.947981 | debian-bookworm | changed 2025-07-18 03:13:09.954532 | 2025-07-18 03:13:09.954635 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-18 03:13:10.550481 | debian-bookworm | changed 2025-07-18 03:13:10.564770 | 2025-07-18 03:13:10.564877 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-18 03:13:10.600961 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:13:10.624620 | 2025-07-18 03:13:10.624727 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-18 03:13:11.191249 | debian-bookworm -> localhost | changed 2025-07-18 03:13:11.200187 | 2025-07-18 03:13:11.200272 | TASK [add-build-sshkey : Add back temp key] 2025-07-18 03:13:11.630539 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4cba55a8560b41dbac99bdaf3ac19aa0/work/4cba55a8560b41dbac99bdaf3ac19aa0_id_rsa (zuul-build-sshkey) 2025-07-18 03:13:11.630756 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009663 2025-07-18 03:13:11.648744 | 2025-07-18 03:13:11.648848 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-18 03:13:12.041049 | debian-bookworm | ok 2025-07-18 03:13:12.046318 | 2025-07-18 03:13:12.046412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-18 03:13:12.075930 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:13:12.086528 | 2025-07-18 03:13:12.086631 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-18 03:13:12.536624 | debian-bookworm | ok 2025-07-18 03:13:12.550282 | 2025-07-18 03:13:12.550392 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-18 03:13:12.596566 | debian-bookworm | ok 2025-07-18 03:13:12.601666 | 2025-07-18 03:13:12.601750 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-18 03:13:12.877026 | debian-bookworm -> localhost | ok 2025-07-18 03:13:12.883204 | 2025-07-18 03:13:12.883303 | TASK [validate-host : Collect information about the host] 2025-07-18 03:13:13.926936 | debian-bookworm | ok 2025-07-18 03:13:13.936964 | 2025-07-18 03:13:13.937062 | TASK [validate-host : Sanitize hostname] 2025-07-18 03:13:14.027381 | debian-bookworm | ok 2025-07-18 03:13:14.057291 | 2025-07-18 03:13:14.057388 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-18 03:13:14.885687 | debian-bookworm -> localhost | changed 2025-07-18 03:13:14.891270 | 2025-07-18 03:13:14.891388 | TASK [validate-host : Collect information about zuul worker] 2025-07-18 03:13:15.303385 | debian-bookworm | ok 2025-07-18 03:13:15.308706 | 2025-07-18 03:13:15.308816 | TASK [validate-host : Write out all zuul information for each host] 2025-07-18 03:13:15.938296 | debian-bookworm -> localhost | changed 2025-07-18 03:13:15.947548 | 2025-07-18 03:13:15.947646 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-18 03:13:16.198143 | debian-bookworm | ok 2025-07-18 03:13:16.205141 | 2025-07-18 03:13:16.205246 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-18 03:13:17.426851 | debian-bookworm | changed: 2025-07-18 03:13:17.427041 | debian-bookworm | cd+++++++++ src/ 2025-07-18 03:13:17.427076 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-18 03:13:17.427101 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-18 03:13:17.427122 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-07-18 03:13:17.427142 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018594 2025-07-18 03:13:42.279897 | 2025-07-18 03:13:42.280021 | TASK [upload-logs : Upload logs to log server] 2025-07-18 03:13:42.914219 | localhost | Output suppressed because no_log was given 2025-07-18 03:13:42.916221 | 2025-07-18 03:13:42.916333 | LOOP [upload-logs : Compress console log and json output] 2025-07-18 03:13:42.994907 | localhost | skipping: Conditional result was False 2025-07-18 03:13:43.006438 | localhost | skipping: Conditional result was False 2025-07-18 03:13:43.017084 | 2025-07-18 03:13:43.017239 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-18 03:13:43.070676 | localhost | skipping: Conditional result was False 2025-07-18 03:13:43.071032 | 2025-07-18 03:13:43.076465 | localhost | skipping: Conditional result was False 2025-07-18 03:13:43.084213 | 2025-07-18 03:13:43.084339 | LOOP [upload-logs : Upload console log and json output]