2025-08-29 19:23:07.692044 | Job console starting 2025-08-29 19:23:07.741233 | Updating git repos 2025-08-29 19:23:07.775710 | Cloning repos into workspace 2025-08-29 19:23:07.823504 | Restoring repo states 2025-08-29 19:23:07.828408 | Merging changes 2025-08-29 19:23:08.299330 | Checking out repos 2025-08-29 19:23:08.362780 | Preparing playbooks 2025-08-29 19:23:09.071322 | Running Ansible setup 2025-08-29 19:23:13.463268 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-29 19:23:14.339859 | 2025-08-29 19:23:14.340027 | PLAY [Base pre] 2025-08-29 19:23:14.356613 | 2025-08-29 19:23:14.356781 | TASK [Setup log path fact] 2025-08-29 19:23:14.397298 | debian-bookworm | ok 2025-08-29 19:23:14.414092 | 2025-08-29 19:23:14.414256 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-29 19:23:14.454428 | debian-bookworm | ok 2025-08-29 19:23:14.465333 | 2025-08-29 19:23:14.465450 | TASK [emit-job-header : Print job information] 2025-08-29 19:23:14.504844 | # Job Information 2025-08-29 19:23:14.505035 | Ansible Version: 2.16.14 2025-08-29 19:23:14.505070 | Job: python-black 2025-08-29 19:23:14.505103 | Pipeline: check 2025-08-29 19:23:14.505127 | Executor: 521e9411259a 2025-08-29 19:23:14.506057 | Triggered by: https://github.com/osism/testbed/pull/2754 2025-08-29 19:23:14.506101 | Event ID: 929c6f00-850d-11f0-8bc6-3d43ab71466a 2025-08-29 19:23:14.511390 | 2025-08-29 19:23:14.511508 | LOOP [emit-job-header : Print node information] 2025-08-29 19:23:14.630265 | debian-bookworm | ok: 2025-08-29 19:23:14.630546 | debian-bookworm | # Node Information 2025-08-29 19:23:14.630607 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-29 19:23:14.630635 | debian-bookworm | Hostname: debian 2025-08-29 19:23:14.630658 | debian-bookworm | Username: zuul 2025-08-29 19:23:14.630680 | debian-bookworm | Distro: Debian 12.11 2025-08-29 19:23:14.630704 | debian-bookworm | Provider: regiocloud-a 2025-08-29 19:23:14.630725 | debian-bookworm | Region: 2025-08-29 19:23:14.630747 | debian-bookworm | Label: debian-bookworm 2025-08-29 19:23:14.630766 | debian-bookworm | Product Name: OpenStack Nova 2025-08-29 19:23:14.630787 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:16f5 2025-08-29 19:23:14.665441 | 2025-08-29 19:23:14.665603 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-29 19:23:15.237812 | debian-bookworm -> localhost | changed 2025-08-29 19:23:15.249071 | 2025-08-29 19:23:15.249226 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-29 19:23:16.453516 | debian-bookworm -> localhost | changed 2025-08-29 19:23:16.465704 | 2025-08-29 19:23:16.465830 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-29 19:23:16.764708 | debian-bookworm -> localhost | ok 2025-08-29 19:23:16.771219 | 2025-08-29 19:23:16.771354 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-29 19:23:16.800227 | debian-bookworm | ok 2025-08-29 19:23:16.820109 | debian-bookworm | included: /var/lib/zuul/builds/e088b641a88c48e19b3232e183b2dcb9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-29 19:23:16.826856 | 2025-08-29 19:23:16.826976 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-29 19:23:17.963323 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-29 19:23:17.963558 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e088b641a88c48e19b3232e183b2dcb9/work/e088b641a88c48e19b3232e183b2dcb9_id_rsa 2025-08-29 19:23:17.963631 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e088b641a88c48e19b3232e183b2dcb9/work/e088b641a88c48e19b3232e183b2dcb9_id_rsa.pub 2025-08-29 19:23:17.963659 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-29 19:23:17.963683 | debian-bookworm -> localhost | SHA256:bMQ43zUvIj5ZnqQDpTpojOrRucy0kclGD/KG9UVL400 zuul-build-sshkey 2025-08-29 19:23:17.963704 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-29 19:23:17.963739 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-29 19:23:17.963760 | debian-bookworm -> localhost | | | 2025-08-29 19:23:17.963781 | debian-bookworm -> localhost | | o | 2025-08-29 19:23:17.963801 | debian-bookworm -> localhost | | o++E o | 2025-08-29 19:23:17.963820 | debian-bookworm -> localhost | | +B=. . o | 2025-08-29 19:23:17.963840 | debian-bookworm -> localhost | | . + o+S.= . . | 2025-08-29 19:23:17.963866 | debian-bookworm -> localhost | | oO.B..+ B o . | 2025-08-29 19:23:17.963886 | debian-bookworm -> localhost | |.o+%oo * o | 2025-08-29 19:23:17.963907 | debian-bookworm -> localhost | |..B +. o | 2025-08-29 19:23:17.963928 | debian-bookworm -> localhost | |o. = | 2025-08-29 19:23:17.963948 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-29 19:23:17.964003 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.630521 2025-08-29 19:23:17.970611 | 2025-08-29 19:23:17.970725 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-29 19:23:17.999447 | debian-bookworm | ok 2025-08-29 19:23:18.010025 | debian-bookworm | included: /var/lib/zuul/builds/e088b641a88c48e19b3232e183b2dcb9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-29 19:23:18.020357 | 2025-08-29 19:23:18.020931 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-29 19:23:18.044499 | debian-bookworm | skipping: Conditional result was False 2025-08-29 19:23:18.050424 | 2025-08-29 19:23:18.050529 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-29 19:23:18.700927 | debian-bookworm | changed 2025-08-29 19:23:18.706541 | 2025-08-29 19:23:18.706667 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-29 19:23:18.986536 | debian-bookworm | ok 2025-08-29 19:23:18.997257 | 2025-08-29 19:23:18.997421 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-29 19:23:19.647322 | debian-bookworm | changed 2025-08-29 19:23:19.660366 | 2025-08-29 19:23:19.660524 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-29 19:23:20.322413 | debian-bookworm | changed 2025-08-29 19:23:20.330229 | 2025-08-29 19:23:20.330364 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-29 19:23:20.365661 | debian-bookworm | skipping: Conditional result was False 2025-08-29 19:23:20.376619 | 2025-08-29 19:23:20.376800 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-29 19:23:20.839088 | debian-bookworm -> localhost | changed 2025-08-29 19:23:20.856069 | 2025-08-29 19:23:20.856204 | TASK [add-build-sshkey : Add back temp key] 2025-08-29 19:23:21.226710 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e088b641a88c48e19b3232e183b2dcb9/work/e088b641a88c48e19b3232e183b2dcb9_id_rsa (zuul-build-sshkey) 2025-08-29 19:23:21.227007 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010950 2025-08-29 19:23:21.235630 | 2025-08-29 19:23:21.235751 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-29 19:23:21.667296 | debian-bookworm | ok 2025-08-29 19:23:21.675144 | 2025-08-29 19:23:21.675295 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-29 19:23:21.700201 | debian-bookworm | skipping: Conditional result was False 2025-08-29 19:23:21.710995 | 2025-08-29 19:23:21.711119 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-29 19:23:22.175879 | debian-bookworm | ok 2025-08-29 19:23:22.187287 | 2025-08-29 19:23:22.187423 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-29 19:23:22.231175 | debian-bookworm | ok 2025-08-29 19:23:22.239125 | 2025-08-29 19:23:22.239273 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-29 19:23:22.548499 | debian-bookworm -> localhost | ok 2025-08-29 19:23:22.564353 | 2025-08-29 19:23:22.564506 | TASK [validate-host : Collect information about the host] 2025-08-29 19:23:23.729774 | debian-bookworm | ok 2025-08-29 19:23:23.740887 | 2025-08-29 19:23:23.741022 | TASK [validate-host : Sanitize hostname] 2025-08-29 19:23:23.852765 | debian-bookworm | ok 2025-08-29 19:23:23.894922 | 2025-08-29 19:23:23.895061 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-29 19:23:24.424893 | debian-bookworm -> localhost | changed 2025-08-29 19:23:24.431071 | 2025-08-29 19:23:24.431210 | TASK [validate-host : Collect information about zuul worker] 2025-08-29 19:23:24.931326 | debian-bookworm | ok 2025-08-29 19:23:24.939918 | 2025-08-29 19:23:24.940075 | TASK [validate-host : Write out all zuul information for each host] 2025-08-29 19:23:25.592519 | debian-bookworm -> localhost | changed 2025-08-29 19:23:25.602732 | 2025-08-29 19:23:25.602874 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-29 19:23:25.906514 | debian-bookworm | ok 2025-08-29 19:23:25.915512 | 2025-08-29 19:23:25.915674 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-29 19:23:27.181894 | debian-bookworm | changed: 2025-08-29 19:23:27.182114 | debian-bookworm | cd+++++++++ src/ 2025-08-29 19:23:27.182150 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-29 19:23:27.182175 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-29 19:23:27.182197 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-08-29 19:23:27.182217 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004561 2025-08-29 19:23:53.060851 | 2025-08-29 19:23:53.060966 | TASK [upload-logs : Upload logs to log server] 2025-08-29 19:23:53.689175 | localhost | Output suppressed because no_log was given 2025-08-29 19:23:53.693293 | 2025-08-29 19:23:53.693512 | LOOP [upload-logs : Compress console log and json output] 2025-08-29 19:23:53.768459 | localhost | skipping: Conditional result was False 2025-08-29 19:23:53.774693 | localhost | skipping: Conditional result was False 2025-08-29 19:23:53.786556 | 2025-08-29 19:23:53.786946 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-29 19:23:53.851712 | localhost | skipping: Conditional result was False 2025-08-29 19:23:53.852034 | 2025-08-29 19:23:53.856687 | localhost | skipping: Conditional result was False 2025-08-29 19:23:53.867545 | 2025-08-29 19:23:53.867738 | LOOP [upload-logs : Upload console log and json output]