2025-08-12 18:42:51.976315 | Job console starting 2025-08-12 18:42:51.988645 | Updating git repos 2025-08-12 18:42:52.025962 | Cloning repos into workspace 2025-08-12 18:42:52.095791 | Restoring repo states 2025-08-12 18:42:52.100871 | Merging changes 2025-08-12 18:42:52.609611 | Checking out repos 2025-08-12 18:42:52.639386 | Preparing playbooks 2025-08-12 18:42:53.274816 | Running Ansible setup 2025-08-12 18:42:57.735502 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-12 18:42:58.956698 | 2025-08-12 18:42:58.956884 | PLAY [Base pre] 2025-08-12 18:42:59.042073 | 2025-08-12 18:42:59.042249 | TASK [Setup log path fact] 2025-08-12 18:42:59.072870 | debian-bookworm | ok 2025-08-12 18:42:59.107861 | 2025-08-12 18:42:59.108049 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-12 18:42:59.207343 | debian-bookworm | ok 2025-08-12 18:42:59.243813 | 2025-08-12 18:42:59.244305 | TASK [emit-job-header : Print job information] 2025-08-12 18:42:59.378152 | # Job Information 2025-08-12 18:42:59.378501 | Ansible Version: 2.16.14 2025-08-12 18:42:59.378800 | Job: python-black 2025-08-12 18:42:59.378874 | Pipeline: check 2025-08-12 18:42:59.378901 | Executor: 521e9411259a 2025-08-12 18:42:59.378924 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/771 2025-08-12 18:42:59.379210 | Event ID: 2746a6e0-77ab-11f0-8383-bc45ca514bbe 2025-08-12 18:42:59.411829 | 2025-08-12 18:42:59.412385 | LOOP [emit-job-header : Print node information] 2025-08-12 18:42:59.749150 | debian-bookworm | ok: 2025-08-12 18:42:59.749398 | debian-bookworm | # Node Information 2025-08-12 18:42:59.749433 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-12 18:42:59.749457 | debian-bookworm | Hostname: debian 2025-08-12 18:42:59.749478 | debian-bookworm | Username: zuul 2025-08-12 18:42:59.749498 | debian-bookworm | Distro: Debian 12.11 2025-08-12 18:42:59.749529 | debian-bookworm | Provider: regiocloud-a 2025-08-12 18:42:59.749554 | debian-bookworm | Region: 2025-08-12 18:42:59.749575 | debian-bookworm | Label: debian-bookworm 2025-08-12 18:42:59.749594 | debian-bookworm | Product Name: OpenStack Nova 2025-08-12 18:42:59.749613 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:b6c 2025-08-12 18:42:59.768607 | 2025-08-12 18:42:59.768750 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-12 18:43:00.581196 | debian-bookworm -> localhost | changed 2025-08-12 18:43:00.597330 | 2025-08-12 18:43:00.597504 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-12 18:43:02.646753 | debian-bookworm -> localhost | changed 2025-08-12 18:43:02.659343 | 2025-08-12 18:43:02.659437 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-12 18:43:03.119328 | debian-bookworm -> localhost | ok 2025-08-12 18:43:03.129731 | 2025-08-12 18:43:03.129830 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-12 18:43:03.158141 | debian-bookworm | ok 2025-08-12 18:43:03.184259 | debian-bookworm | included: /var/lib/zuul/builds/c0add40e57c54797975fabd758e7c131/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-12 18:43:03.190982 | 2025-08-12 18:43:03.191171 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-12 18:43:05.771565 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-12 18:43:05.771757 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c0add40e57c54797975fabd758e7c131/work/c0add40e57c54797975fabd758e7c131_id_rsa 2025-08-12 18:43:05.771795 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c0add40e57c54797975fabd758e7c131/work/c0add40e57c54797975fabd758e7c131_id_rsa.pub 2025-08-12 18:43:05.771821 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-12 18:43:05.771846 | debian-bookworm -> localhost | SHA256:JCDs5YT/NIZH5Kv2/lF+oXv5UpzmK42XMnePFgj91OA zuul-build-sshkey 2025-08-12 18:43:05.771868 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-12 18:43:05.771898 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-12 18:43:05.771920 | debian-bookworm -> localhost | | ...... | 2025-08-12 18:43:05.771942 | debian-bookworm -> localhost | | o.oo. . | 2025-08-12 18:43:05.771963 | debian-bookworm -> localhost | | . = oo . . . o | 2025-08-12 18:43:05.771984 | debian-bookworm -> localhost | | . + =+ . . E .| 2025-08-12 18:43:05.772005 | debian-bookworm -> localhost | | =..S ...= . | 2025-08-12 18:43:05.772055 | debian-bookworm -> localhost | | .. o ...B | 2025-08-12 18:43:05.772076 | debian-bookworm -> localhost | | o . o .B o | 2025-08-12 18:43:05.772096 | debian-bookworm -> localhost | | . . . oO B..| 2025-08-12 18:43:05.772118 | debian-bookworm -> localhost | | .o.. .. X+oo| 2025-08-12 18:43:05.772139 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-12 18:43:05.772190 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.910634 2025-08-12 18:43:05.780582 | 2025-08-12 18:43:05.780681 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-12 18:43:05.829712 | debian-bookworm | ok 2025-08-12 18:43:05.879916 | debian-bookworm | included: /var/lib/zuul/builds/c0add40e57c54797975fabd758e7c131/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-12 18:43:05.972917 | 2025-08-12 18:43:05.975055 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-12 18:43:06.049770 | debian-bookworm | skipping: Conditional result was False 2025-08-12 18:43:06.056998 | 2025-08-12 18:43:06.057100 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-12 18:43:07.343876 | debian-bookworm | changed 2025-08-12 18:43:07.349912 | 2025-08-12 18:43:07.350004 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-12 18:43:07.659397 | debian-bookworm | ok 2025-08-12 18:43:07.690143 | 2025-08-12 18:43:07.690257 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-12 18:43:08.526951 | debian-bookworm | changed 2025-08-12 18:43:08.536415 | 2025-08-12 18:43:08.536507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-12 18:43:09.306056 | debian-bookworm | changed 2025-08-12 18:43:09.314138 | 2025-08-12 18:43:09.314222 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-12 18:43:09.348459 | debian-bookworm | skipping: Conditional result was False 2025-08-12 18:43:09.356529 | 2025-08-12 18:43:09.356617 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-12 18:43:10.337422 | debian-bookworm -> localhost | changed 2025-08-12 18:43:10.348265 | 2025-08-12 18:43:10.348356 | TASK [add-build-sshkey : Add back temp key] 2025-08-12 18:43:11.158428 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c0add40e57c54797975fabd758e7c131/work/c0add40e57c54797975fabd758e7c131_id_rsa (zuul-build-sshkey) 2025-08-12 18:43:11.158629 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.044228 2025-08-12 18:43:11.165236 | 2025-08-12 18:43:11.165316 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-12 18:43:11.715089 | debian-bookworm | ok 2025-08-12 18:43:11.721852 | 2025-08-12 18:43:11.722508 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-12 18:43:11.760758 | debian-bookworm | skipping: Conditional result was False 2025-08-12 18:43:11.769145 | 2025-08-12 18:43:11.769222 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-12 18:43:12.297698 | debian-bookworm | ok 2025-08-12 18:43:12.318909 | 2025-08-12 18:43:12.319071 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-12 18:43:12.479353 | debian-bookworm | ok 2025-08-12 18:43:12.483430 | 2025-08-12 18:43:12.483505 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-12 18:43:13.464924 | debian-bookworm -> localhost | ok 2025-08-12 18:43:13.470218 | 2025-08-12 18:43:13.470298 | TASK [validate-host : Collect information about the host] 2025-08-12 18:43:15.417419 | debian-bookworm | ok 2025-08-12 18:43:15.437217 | 2025-08-12 18:43:15.437314 | TASK [validate-host : Sanitize hostname] 2025-08-12 18:43:15.625689 | debian-bookworm | ok 2025-08-12 18:43:15.714797 | 2025-08-12 18:43:15.714921 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-12 18:43:16.999133 | debian-bookworm -> localhost | changed 2025-08-12 18:43:17.003733 | 2025-08-12 18:43:17.003813 | TASK [validate-host : Collect information about zuul worker] 2025-08-12 18:43:17.589044 | debian-bookworm | ok 2025-08-12 18:43:17.593556 | 2025-08-12 18:43:17.593647 | TASK [validate-host : Write out all zuul information for each host] 2025-08-12 18:43:18.569283 | debian-bookworm -> localhost | changed 2025-08-12 18:43:18.576849 | 2025-08-12 18:43:18.576927 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-12 18:43:18.865235 | debian-bookworm | ok 2025-08-12 18:43:18.869620 | 2025-08-12 18:43:18.869696 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-12 18:43:20.309556 | debian-bookworm | changed: 2025-08-12 18:43:20.309698 | debian-bookworm | cd+++++++++ src/ 2025-08-12 18:43:20.309775 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-12 18:43:20.309798 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-12 18:43:20.309817 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-12 18:43:20.309835 | debian-bookworm | Containerfile 2025-08-12 18:43:20.309949 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003413 2025-08-12 18:43:49.599397 | 2025-08-12 18:43:49.599475 | TASK [upload-logs : Upload logs to log server] 2025-08-12 18:43:50.121762 | localhost | Output suppressed because no_log was given 2025-08-12 18:43:50.123170 | 2025-08-12 18:43:50.123253 | LOOP [upload-logs : Compress console log and json output] 2025-08-12 18:43:50.196770 | localhost | skipping: Conditional result was False 2025-08-12 18:43:50.212563 | localhost | skipping: Conditional result was False 2025-08-12 18:43:50.219187 | 2025-08-12 18:43:50.219282 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-12 18:43:50.280256 | localhost | skipping: Conditional result was False 2025-08-12 18:43:50.280506 | 2025-08-12 18:43:50.284132 | localhost | skipping: Conditional result was False 2025-08-12 18:43:50.294116 | 2025-08-12 18:43:50.294205 | LOOP [upload-logs : Upload console log and json output]