2025-07-09 23:45:04.579635 | Job console starting 2025-07-09 23:45:04.607910 | Updating git repos 2025-07-09 23:45:04.632589 | Cloning repos into workspace 2025-07-09 23:45:04.703281 | Restoring repo states 2025-07-09 23:45:04.716241 | Merging changes 2025-07-09 23:45:05.431659 | Checking out repos 2025-07-09 23:45:05.495915 | Preparing playbooks 2025-07-09 23:45:07.287184 | Running Ansible setup 2025-07-09 23:45:15.498693 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 23:45:17.574064 | 2025-07-09 23:45:17.574251 | PLAY [Base pre] 2025-07-09 23:45:17.653642 | 2025-07-09 23:45:17.653822 | TASK [Setup log path fact] 2025-07-09 23:45:17.695606 | debian-bookworm | ok 2025-07-09 23:45:17.748883 | 2025-07-09 23:45:17.749069 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 23:45:17.851862 | debian-bookworm | ok 2025-07-09 23:45:17.871721 | 2025-07-09 23:45:17.871871 | TASK [emit-job-header : Print job information] 2025-07-09 23:45:18.012245 | # Job Information 2025-07-09 23:45:18.012537 | Ansible Version: 2.16.14 2025-07-09 23:45:18.012580 | Job: python-black 2025-07-09 23:45:18.012614 | Pipeline: check 2025-07-09 23:45:18.012638 | Executor: 521e9411259a 2025-07-09 23:45:18.012659 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/764 2025-07-09 23:45:18.012682 | Event ID: b75e0680-5d1e-11f0-9b13-2371c3761600 2025-07-09 23:45:18.021294 | 2025-07-09 23:45:18.021490 | LOOP [emit-job-header : Print node information] 2025-07-09 23:45:18.413963 | debian-bookworm | ok: 2025-07-09 23:45:18.414163 | debian-bookworm | # Node Information 2025-07-09 23:45:18.414200 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 23:45:18.414226 | debian-bookworm | Hostname: debian 2025-07-09 23:45:18.414249 | debian-bookworm | Username: zuul 2025-07-09 23:45:18.414270 | debian-bookworm | Distro: Debian 12.11 2025-07-09 23:45:18.414294 | debian-bookworm | Provider: regiocloud-a 2025-07-09 23:45:18.414314 | debian-bookworm | Region: 2025-07-09 23:45:18.414335 | debian-bookworm | Label: debian-bookworm 2025-07-09 23:45:18.414356 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 23:45:18.414376 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe29:50af 2025-07-09 23:45:18.433365 | 2025-07-09 23:45:18.433528 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 23:45:19.588221 | debian-bookworm -> localhost | changed 2025-07-09 23:45:19.594996 | 2025-07-09 23:45:19.595099 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 23:45:21.475112 | debian-bookworm -> localhost | changed 2025-07-09 23:45:21.483586 | 2025-07-09 23:45:21.483684 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 23:45:22.012485 | debian-bookworm -> localhost | ok 2025-07-09 23:45:22.017412 | 2025-07-09 23:45:22.017521 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 23:45:22.074415 | debian-bookworm | ok 2025-07-09 23:45:22.107200 | debian-bookworm | included: /var/lib/zuul/builds/c1905adc47594c45bd193485f305e837/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 23:45:22.112179 | 2025-07-09 23:45:22.112262 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 23:45:24.295191 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 23:45:24.295368 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c1905adc47594c45bd193485f305e837/work/c1905adc47594c45bd193485f305e837_id_rsa 2025-07-09 23:45:24.295400 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c1905adc47594c45bd193485f305e837/work/c1905adc47594c45bd193485f305e837_id_rsa.pub 2025-07-09 23:45:24.295422 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 23:45:24.295453 | debian-bookworm -> localhost | SHA256:CPhuloCZnS0+tfaY3OQeJ1eGRRN+eFD/KqKWGwjZLmc zuul-build-sshkey 2025-07-09 23:45:24.295471 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 23:45:24.295498 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 23:45:24.295517 | debian-bookworm -> localhost | | =o. | 2025-07-09 23:45:24.295535 | debian-bookworm -> localhost | | . o + . | 2025-07-09 23:45:24.295552 | debian-bookworm -> localhost | | . . + o . | 2025-07-09 23:45:24.295568 | debian-bookworm -> localhost | | = + + . o o . | 2025-07-09 23:45:24.295584 | debian-bookworm -> localhost | |+ = * o S o .| 2025-07-09 23:45:24.295602 | debian-bookworm -> localhost | | . = = . o . | 2025-07-09 23:45:24.295619 | debian-bookworm -> localhost | | o O E +.. . . | 2025-07-09 23:45:24.295636 | debian-bookworm -> localhost | | * @ =oo . . | 2025-07-09 23:45:24.295653 | debian-bookworm -> localhost | | +.=.o. | 2025-07-09 23:45:24.295670 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 23:45:24.295714 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.327929 2025-07-09 23:45:24.300723 | 2025-07-09 23:45:24.300797 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 23:45:24.339789 | debian-bookworm | ok 2025-07-09 23:45:24.360669 | debian-bookworm | included: /var/lib/zuul/builds/c1905adc47594c45bd193485f305e837/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 23:45:24.384849 | 2025-07-09 23:45:24.384945 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 23:45:24.417696 | debian-bookworm | skipping: Conditional result was False 2025-07-09 23:45:24.422420 | 2025-07-09 23:45:24.422508 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 23:45:25.138903 | debian-bookworm | changed 2025-07-09 23:45:25.157059 | 2025-07-09 23:45:25.157171 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 23:45:25.438543 | debian-bookworm | ok 2025-07-09 23:45:25.443949 | 2025-07-09 23:45:25.444038 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 23:45:26.156504 | debian-bookworm | changed 2025-07-09 23:45:26.167364 | 2025-07-09 23:45:26.167492 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 23:45:26.805896 | debian-bookworm | changed 2025-07-09 23:45:26.810758 | 2025-07-09 23:45:26.810885 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 23:45:26.849520 | debian-bookworm | skipping: Conditional result was False 2025-07-09 23:45:26.854927 | 2025-07-09 23:45:26.855009 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 23:45:27.567496 | debian-bookworm -> localhost | changed 2025-07-09 23:45:27.576379 | 2025-07-09 23:45:27.576494 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 23:45:27.832905 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c1905adc47594c45bd193485f305e837/work/c1905adc47594c45bd193485f305e837_id_rsa (zuul-build-sshkey) 2025-07-09 23:45:27.833139 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015481 2025-07-09 23:45:27.840880 | 2025-07-09 23:45:27.840987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 23:45:28.233992 | debian-bookworm | ok 2025-07-09 23:45:28.238783 | 2025-07-09 23:45:28.253539 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 23:45:28.286938 | debian-bookworm | skipping: Conditional result was False 2025-07-09 23:45:28.305581 | 2025-07-09 23:45:28.306268 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 23:45:28.845714 | debian-bookworm | ok 2025-07-09 23:45:28.855734 | 2025-07-09 23:45:28.855839 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 23:45:28.903808 | debian-bookworm | ok 2025-07-09 23:45:28.908847 | 2025-07-09 23:45:28.908940 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 23:45:29.452738 | debian-bookworm -> localhost | ok 2025-07-09 23:45:29.477145 | 2025-07-09 23:45:29.477464 | TASK [validate-host : Collect information about the host] 2025-07-09 23:45:30.706815 | debian-bookworm | ok 2025-07-09 23:45:30.715334 | 2025-07-09 23:45:30.715420 | TASK [validate-host : Sanitize hostname] 2025-07-09 23:45:30.849607 | debian-bookworm | ok 2025-07-09 23:45:30.877856 | 2025-07-09 23:45:30.877951 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 23:45:31.767771 | debian-bookworm -> localhost | changed 2025-07-09 23:45:31.775705 | 2025-07-09 23:45:31.775823 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 23:45:32.238340 | debian-bookworm | ok 2025-07-09 23:45:32.246118 | 2025-07-09 23:45:32.246266 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 23:45:33.082926 | debian-bookworm -> localhost | changed 2025-07-09 23:45:33.091978 | 2025-07-09 23:45:33.092084 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 23:45:33.410904 | debian-bookworm | ok 2025-07-09 23:45:33.418632 | 2025-07-09 23:45:33.418733 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 23:45:34.428353 | debian-bookworm | changed: 2025-07-09 23:45:34.428566 | debian-bookworm | cd+++++++++ src/ 2025-07-09 23:45:34.428603 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 23:45:34.428628 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 23:45:34.428649 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-07-09 23:45:34.428670 | debian-bookworm | Containerfile 2025-07-09 23:45:34.428799 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010025 2025-07-09 23:46:00.257376 | 2025-07-09 23:46:00.257547 | TASK [upload-logs : Upload logs to log server] 2025-07-09 23:46:00.975502 | localhost | Output suppressed because no_log was given 2025-07-09 23:46:00.977499 | 2025-07-09 23:46:00.977616 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 23:46:01.035820 | localhost | skipping: Conditional result was False 2025-07-09 23:46:01.042136 | localhost | skipping: Conditional result was False 2025-07-09 23:46:01.049409 | 2025-07-09 23:46:01.049546 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 23:46:01.104790 | localhost | skipping: Conditional result was False 2025-07-09 23:46:01.105145 | 2025-07-09 23:46:01.112756 | localhost | skipping: Conditional result was False 2025-07-09 23:46:01.118661 | 2025-07-09 23:46:01.118800 | LOOP [upload-logs : Upload console log and json output]