2025-07-25 18:16:29.212941 | Job console starting 2025-07-25 18:16:29.246745 | Updating git repos 2025-07-25 18:16:29.323197 | Cloning repos into workspace 2025-07-25 18:16:29.434807 | Restoring repo states 2025-07-25 18:16:29.474112 | Merging changes 2025-07-25 18:16:30.285352 | Checking out repos 2025-07-25 18:16:30.454092 | Preparing playbooks 2025-07-25 18:16:31.773883 | Running Ansible setup 2025-07-25 18:16:37.622546 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-25 18:16:39.060883 | 2025-07-25 18:16:39.061062 | PLAY [Base pre] 2025-07-25 18:16:39.081084 | 2025-07-25 18:16:39.081234 | TASK [Setup log path fact] 2025-07-25 18:16:39.112324 | debian-bookworm | ok 2025-07-25 18:16:39.141654 | 2025-07-25 18:16:39.141814 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-25 18:16:39.191084 | debian-bookworm | ok 2025-07-25 18:16:39.204998 | 2025-07-25 18:16:39.205984 | TASK [emit-job-header : Print job information] 2025-07-25 18:16:39.245481 | # Job Information 2025-07-25 18:16:39.245663 | Ansible Version: 2.16.14 2025-07-25 18:16:39.245698 | Job: python-black 2025-07-25 18:16:39.245730 | Pipeline: check 2025-07-25 18:16:39.245754 | Executor: 521e9411259a 2025-07-25 18:16:39.245775 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1958 2025-07-25 18:16:39.245798 | Event ID: 775c1100-6983-11f0-8eeb-f2725e6733bd 2025-07-25 18:16:39.250714 | 2025-07-25 18:16:39.250825 | LOOP [emit-job-header : Print node information] 2025-07-25 18:16:39.449556 | debian-bookworm | ok: 2025-07-25 18:16:39.449807 | debian-bookworm | # Node Information 2025-07-25 18:16:39.449858 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-25 18:16:39.449894 | debian-bookworm | Hostname: debian 2025-07-25 18:16:39.449926 | debian-bookworm | Username: zuul 2025-07-25 18:16:39.449973 | debian-bookworm | Distro: Debian 12.11 2025-07-25 18:16:39.450010 | debian-bookworm | Provider: regiocloud-a 2025-07-25 18:16:39.450040 | debian-bookworm | Region: 2025-07-25 18:16:39.450072 | debian-bookworm | Label: debian-bookworm 2025-07-25 18:16:39.450101 | debian-bookworm | Product Name: OpenStack Nova 2025-07-25 18:16:39.450130 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe01:1b1 2025-07-25 18:16:39.490669 | 2025-07-25 18:16:39.490815 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-25 18:16:40.444981 | debian-bookworm -> localhost | changed 2025-07-25 18:16:40.452596 | 2025-07-25 18:16:40.452726 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-25 18:16:42.373599 | debian-bookworm -> localhost | changed 2025-07-25 18:16:42.382360 | 2025-07-25 18:16:42.382447 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-25 18:16:43.231468 | debian-bookworm -> localhost | ok 2025-07-25 18:16:43.236336 | 2025-07-25 18:16:43.236435 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-25 18:16:43.284204 | debian-bookworm | ok 2025-07-25 18:16:43.320001 | debian-bookworm | included: /var/lib/zuul/builds/0ef1232fc6014411ab06c64089123630/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-25 18:16:43.339844 | 2025-07-25 18:16:43.339940 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-25 18:16:45.137993 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-25 18:16:45.138491 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ef1232fc6014411ab06c64089123630/work/0ef1232fc6014411ab06c64089123630_id_rsa 2025-07-25 18:16:45.138583 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ef1232fc6014411ab06c64089123630/work/0ef1232fc6014411ab06c64089123630_id_rsa.pub 2025-07-25 18:16:45.138640 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-25 18:16:45.138690 | debian-bookworm -> localhost | SHA256:GPqJWX1uUzh7Rdoa0DOeIoULJVWoMlS/0WBfFbgfzME zuul-build-sshkey 2025-07-25 18:16:45.138736 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-25 18:16:45.138796 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-25 18:16:45.138945 | debian-bookworm -> localhost | | .o.=o. .+o. | 2025-07-25 18:16:45.139054 | debian-bookworm -> localhost | | . =.= o. E | 2025-07-25 18:16:45.139093 | debian-bookworm -> localhost | | . o.+ = ++.. | 2025-07-25 18:16:45.139129 | debian-bookworm -> localhost | | o..= = +.B+ | 2025-07-25 18:16:45.139165 | debian-bookworm -> localhost | | .oo S = *.o. | 2025-07-25 18:16:45.139208 | debian-bookworm -> localhost | | = . + = +. | 2025-07-25 18:16:45.139245 | debian-bookworm -> localhost | | o o = o | 2025-07-25 18:16:45.139281 | debian-bookworm -> localhost | | . o | 2025-07-25 18:16:45.139319 | debian-bookworm -> localhost | | | 2025-07-25 18:16:45.139356 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-25 18:16:45.139462 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.991644 2025-07-25 18:16:45.152010 | 2025-07-25 18:16:45.152131 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-25 18:16:45.171564 | debian-bookworm | ok 2025-07-25 18:16:45.180438 | debian-bookworm | included: /var/lib/zuul/builds/0ef1232fc6014411ab06c64089123630/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-25 18:16:45.189254 | 2025-07-25 18:16:45.189349 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-25 18:16:45.203056 | debian-bookworm | skipping: Conditional result was False 2025-07-25 18:16:45.209597 | 2025-07-25 18:16:45.209694 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-25 18:16:45.860426 | debian-bookworm | changed 2025-07-25 18:16:45.867310 | 2025-07-25 18:16:45.867416 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-25 18:16:46.128431 | debian-bookworm | ok 2025-07-25 18:16:46.136139 | 2025-07-25 18:16:46.136249 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-25 18:16:46.764157 | debian-bookworm | changed 2025-07-25 18:16:46.770481 | 2025-07-25 18:16:46.770576 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-25 18:16:47.473394 | debian-bookworm | changed 2025-07-25 18:16:47.478899 | 2025-07-25 18:16:47.479006 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-25 18:16:47.505411 | debian-bookworm | skipping: Conditional result was False 2025-07-25 18:16:47.514290 | 2025-07-25 18:16:47.514391 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-25 18:16:48.107389 | debian-bookworm -> localhost | changed 2025-07-25 18:16:48.118546 | 2025-07-25 18:16:48.118652 | TASK [add-build-sshkey : Add back temp key] 2025-07-25 18:16:48.574493 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ef1232fc6014411ab06c64089123630/work/0ef1232fc6014411ab06c64089123630_id_rsa (zuul-build-sshkey) 2025-07-25 18:16:48.575083 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010441 2025-07-25 18:16:48.582921 | 2025-07-25 18:16:48.583021 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-25 18:16:49.029899 | debian-bookworm | ok 2025-07-25 18:16:49.035235 | 2025-07-25 18:16:49.035344 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-25 18:16:49.058741 | debian-bookworm | skipping: Conditional result was False 2025-07-25 18:16:49.073341 | 2025-07-25 18:16:49.073469 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-25 18:16:49.713869 | debian-bookworm | ok 2025-07-25 18:16:49.752639 | 2025-07-25 18:16:49.752799 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-25 18:16:49.821090 | debian-bookworm | ok 2025-07-25 18:16:49.832269 | 2025-07-25 18:16:49.832449 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-25 18:16:50.366648 | debian-bookworm -> localhost | ok 2025-07-25 18:16:50.374024 | 2025-07-25 18:16:50.374138 | TASK [validate-host : Collect information about the host] 2025-07-25 18:16:51.540053 | debian-bookworm | ok 2025-07-25 18:16:51.558080 | 2025-07-25 18:16:51.558225 | TASK [validate-host : Sanitize hostname] 2025-07-25 18:16:51.706027 | debian-bookworm | ok 2025-07-25 18:16:51.764663 | 2025-07-25 18:16:51.764808 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-25 18:16:52.620423 | debian-bookworm -> localhost | changed 2025-07-25 18:16:52.626886 | 2025-07-25 18:16:52.627029 | TASK [validate-host : Collect information about zuul worker] 2025-07-25 18:16:53.089771 | debian-bookworm | ok 2025-07-25 18:16:53.094730 | 2025-07-25 18:16:53.097526 | TASK [validate-host : Write out all zuul information for each host] 2025-07-25 18:16:54.037048 | debian-bookworm -> localhost | changed 2025-07-25 18:16:54.061237 | 2025-07-25 18:16:54.061372 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-25 18:16:54.326716 | debian-bookworm | ok 2025-07-25 18:16:54.336099 | 2025-07-25 18:16:54.336236 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-25 18:16:55.923936 | debian-bookworm | changed: 2025-07-25 18:16:55.924168 | debian-bookworm | cd+++++++++ src/ 2025-07-25 18:16:55.924203 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-25 18:16:55.924228 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-25 18:16:55.924249 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-07-25 18:16:55.924270 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005042 2025-07-25 18:17:24.312607 | 2025-07-25 18:17:24.312743 | TASK [upload-logs : Upload logs to log server] 2025-07-25 18:17:24.954039 | localhost | Output suppressed because no_log was given 2025-07-25 18:17:24.959017 | 2025-07-25 18:17:24.959264 | LOOP [upload-logs : Compress console log and json output] 2025-07-25 18:17:25.033010 | localhost | skipping: Conditional result was False 2025-07-25 18:17:25.041788 | localhost | skipping: Conditional result was False 2025-07-25 18:17:25.051849 | 2025-07-25 18:17:25.052117 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-25 18:17:25.124073 | localhost | skipping: Conditional result was False 2025-07-25 18:17:25.124411 | 2025-07-25 18:17:25.132918 | localhost | skipping: Conditional result was False 2025-07-25 18:17:25.140188 | 2025-07-25 18:17:25.140336 | LOOP [upload-logs : Upload console log and json output]