2025-07-31 09:04:05.670990 | Job console starting 2025-07-31 09:04:05.683157 | Updating git repos 2025-07-31 09:04:05.728842 | Cloning repos into workspace 2025-07-31 09:04:05.795664 | Restoring repo states 2025-07-31 09:04:05.830197 | Merging changes 2025-07-31 09:04:06.537968 | Checking out repos 2025-07-31 09:04:06.613282 | Preparing playbooks 2025-07-31 09:04:07.530816 | Running Ansible setup 2025-07-31 09:04:12.089208 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-31 09:04:12.889869 | 2025-07-31 09:04:12.890040 | PLAY [Base pre] 2025-07-31 09:04:12.906532 | 2025-07-31 09:04:12.906705 | TASK [Setup log path fact] 2025-07-31 09:04:12.936915 | debian-bookworm | ok 2025-07-31 09:04:12.969612 | 2025-07-31 09:04:12.969795 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-31 09:04:13.025671 | debian-bookworm | ok 2025-07-31 09:04:13.035568 | 2025-07-31 09:04:13.035694 | TASK [emit-job-header : Print job information] 2025-07-31 09:04:13.105100 | # Job Information 2025-07-31 09:04:13.105292 | Ansible Version: 2.16.14 2025-07-31 09:04:13.105327 | Job: python-black 2025-07-31 09:04:13.105359 | Pipeline: check 2025-07-31 09:04:13.105381 | Executor: 521e9411259a 2025-07-31 09:04:13.105401 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1962 2025-07-31 09:04:13.105423 | Event ID: 4a898a90-6ded-11f0-9f7d-96d7896770d8 2025-07-31 09:04:13.112158 | 2025-07-31 09:04:13.112277 | LOOP [emit-job-header : Print node information] 2025-07-31 09:04:13.220936 | debian-bookworm | ok: 2025-07-31 09:04:13.221123 | debian-bookworm | # Node Information 2025-07-31 09:04:13.221159 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-31 09:04:13.221185 | debian-bookworm | Hostname: debian 2025-07-31 09:04:13.221206 | debian-bookworm | Username: zuul 2025-07-31 09:04:13.221227 | debian-bookworm | Distro: Debian 12.11 2025-07-31 09:04:13.221251 | debian-bookworm | Provider: regiocloud-a 2025-07-31 09:04:13.221273 | debian-bookworm | Region: 2025-07-31 09:04:13.221293 | debian-bookworm | Label: debian-bookworm 2025-07-31 09:04:13.221312 | debian-bookworm | Product Name: OpenStack Nova 2025-07-31 09:04:13.221332 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe73:7c14 2025-07-31 09:04:13.242759 | 2025-07-31 09:04:13.242929 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-31 09:04:13.716273 | debian-bookworm -> localhost | changed 2025-07-31 09:04:13.728449 | 2025-07-31 09:04:13.728649 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-31 09:04:14.885926 | debian-bookworm -> localhost | changed 2025-07-31 09:04:14.905152 | 2025-07-31 09:04:14.905323 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-31 09:04:15.259760 | debian-bookworm -> localhost | ok 2025-07-31 09:04:15.280682 | 2025-07-31 09:04:15.280827 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-31 09:04:15.335399 | debian-bookworm | ok 2025-07-31 09:04:15.363279 | debian-bookworm | included: /var/lib/zuul/builds/85e4fc258a8e4f4a9d25fb9d27adccea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-31 09:04:15.369874 | 2025-07-31 09:04:15.370004 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-31 09:04:16.657623 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-31 09:04:16.657840 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/85e4fc258a8e4f4a9d25fb9d27adccea/work/85e4fc258a8e4f4a9d25fb9d27adccea_id_rsa 2025-07-31 09:04:16.657880 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/85e4fc258a8e4f4a9d25fb9d27adccea/work/85e4fc258a8e4f4a9d25fb9d27adccea_id_rsa.pub 2025-07-31 09:04:16.657906 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-31 09:04:16.657929 | debian-bookworm -> localhost | SHA256:/bZRhElwcGM19BWxbl8IQIynXDwoXGQJAsrIecuDKmk zuul-build-sshkey 2025-07-31 09:04:16.657951 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-31 09:04:16.657988 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-31 09:04:16.658010 | debian-bookworm -> localhost | | .....++B=o*o+o+| 2025-07-31 09:04:16.658032 | debian-bookworm -> localhost | |+.. .o.+ ** + oo| 2025-07-31 09:04:16.658052 | debian-bookworm -> localhost | |o+ . o + .+ ...| 2025-07-31 09:04:16.658071 | debian-bookworm -> localhost | | + . o. o.. | 2025-07-31 09:04:16.658091 | debian-bookworm -> localhost | | . + S . oo.| 2025-07-31 09:04:16.658118 | debian-bookworm -> localhost | |.. . . .. o| 2025-07-31 09:04:16.658139 | debian-bookworm -> localhost | |+E + .| 2025-07-31 09:04:16.658158 | debian-bookworm -> localhost | |o . o | 2025-07-31 09:04:16.658179 | debian-bookworm -> localhost | | . | 2025-07-31 09:04:16.658199 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-31 09:04:16.658250 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.531375 2025-07-31 09:04:16.664836 | 2025-07-31 09:04:16.665113 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-31 09:04:16.704228 | debian-bookworm | ok 2025-07-31 09:04:16.718639 | debian-bookworm | included: /var/lib/zuul/builds/85e4fc258a8e4f4a9d25fb9d27adccea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-31 09:04:16.729038 | 2025-07-31 09:04:16.729143 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-31 09:04:16.752758 | debian-bookworm | skipping: Conditional result was False 2025-07-31 09:04:16.759669 | 2025-07-31 09:04:16.759777 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-31 09:04:17.465835 | debian-bookworm | changed 2025-07-31 09:04:17.475589 | 2025-07-31 09:04:17.475723 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-31 09:04:17.737284 | debian-bookworm | ok 2025-07-31 09:04:17.743291 | 2025-07-31 09:04:17.743412 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-31 09:04:18.423279 | debian-bookworm | changed 2025-07-31 09:04:18.434429 | 2025-07-31 09:04:18.434593 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-31 09:04:19.207567 | debian-bookworm | changed 2025-07-31 09:04:19.216020 | 2025-07-31 09:04:19.216146 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-31 09:04:19.239936 | debian-bookworm | skipping: Conditional result was False 2025-07-31 09:04:19.246966 | 2025-07-31 09:04:19.247094 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-31 09:04:19.741435 | debian-bookworm -> localhost | changed 2025-07-31 09:04:19.757221 | 2025-07-31 09:04:19.757364 | TASK [add-build-sshkey : Add back temp key] 2025-07-31 09:04:20.200141 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/85e4fc258a8e4f4a9d25fb9d27adccea/work/85e4fc258a8e4f4a9d25fb9d27adccea_id_rsa (zuul-build-sshkey) 2025-07-31 09:04:20.200389 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015613 2025-07-31 09:04:20.208739 | 2025-07-31 09:04:20.208863 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-31 09:04:20.611408 | debian-bookworm | ok 2025-07-31 09:04:20.623029 | 2025-07-31 09:04:20.623170 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-31 09:04:20.647968 | debian-bookworm | skipping: Conditional result was False 2025-07-31 09:04:20.658726 | 2025-07-31 09:04:20.658886 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-31 09:04:21.108258 | debian-bookworm | ok 2025-07-31 09:04:21.132231 | 2025-07-31 09:04:21.132388 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-31 09:04:21.201358 | debian-bookworm | ok 2025-07-31 09:04:21.206677 | 2025-07-31 09:04:21.206799 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-31 09:04:21.593211 | debian-bookworm -> localhost | ok 2025-07-31 09:04:21.599993 | 2025-07-31 09:04:21.600186 | TASK [validate-host : Collect information about the host] 2025-07-31 09:04:22.770736 | debian-bookworm | ok 2025-07-31 09:04:22.785198 | 2025-07-31 09:04:22.785412 | TASK [validate-host : Sanitize hostname] 2025-07-31 09:04:22.927466 | debian-bookworm | ok 2025-07-31 09:04:22.969361 | 2025-07-31 09:04:22.969531 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-31 09:04:23.648594 | debian-bookworm -> localhost | changed 2025-07-31 09:04:23.657439 | 2025-07-31 09:04:23.657811 | TASK [validate-host : Collect information about zuul worker] 2025-07-31 09:04:24.093057 | debian-bookworm | ok 2025-07-31 09:04:24.100176 | 2025-07-31 09:04:24.100312 | TASK [validate-host : Write out all zuul information for each host] 2025-07-31 09:04:24.712033 | debian-bookworm -> localhost | changed 2025-07-31 09:04:24.727061 | 2025-07-31 09:04:24.727191 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-31 09:04:25.001712 | debian-bookworm | ok 2025-07-31 09:04:25.007924 | 2025-07-31 09:04:25.008056 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-31 09:04:26.221802 | debian-bookworm | changed: 2025-07-31 09:04:26.221982 | debian-bookworm | cd+++++++++ src/ 2025-07-31 09:04:26.222017 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-31 09:04:26.222042 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-31 09:04:26.222063 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-07-31 09:04:26.222082 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006625 2025-07-31 09:04:51.963593 | 2025-07-31 09:04:51.963706 | TASK [upload-logs : Upload logs to log server] 2025-07-31 09:04:52.538052 | localhost | Output suppressed because no_log was given 2025-07-31 09:04:52.540027 | 2025-07-31 09:04:52.540143 | LOOP [upload-logs : Compress console log and json output] 2025-07-31 09:04:52.585963 | localhost | skipping: Conditional result was False 2025-07-31 09:04:52.590725 | localhost | skipping: Conditional result was False 2025-07-31 09:04:52.600337 | 2025-07-31 09:04:52.600512 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-31 09:04:52.658041 | localhost | skipping: Conditional result was False 2025-07-31 09:04:52.658338 | 2025-07-31 09:04:52.665969 | localhost | skipping: Conditional result was False 2025-07-31 09:04:52.680853 | 2025-07-31 09:04:52.681046 | LOOP [upload-logs : Upload console log and json output]