2025-09-17 15:19:11.905422 | Job console starting 2025-09-17 15:19:11.922754 | Updating git repos 2025-09-17 15:19:11.960440 | Cloning repos into workspace 2025-09-17 15:19:12.076614 | Restoring repo states 2025-09-17 15:19:12.084718 | Merging changes 2025-09-17 15:19:12.602539 | Checking out repos 2025-09-17 15:19:12.684142 | Preparing playbooks 2025-09-17 15:19:13.455106 | Running Ansible setup 2025-09-17 15:19:18.503196 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-17 15:19:20.404560 | 2025-09-17 15:19:20.404775 | PLAY [Base pre] 2025-09-17 15:19:20.480172 | 2025-09-17 15:19:20.483345 | TASK [Setup log path fact] 2025-09-17 15:19:20.571397 | debian-bookworm | ok 2025-09-17 15:19:20.590459 | 2025-09-17 15:19:20.590623 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-17 15:19:20.623094 | debian-bookworm | ok 2025-09-17 15:19:20.650233 | 2025-09-17 15:19:20.650370 | TASK [emit-job-header : Print job information] 2025-09-17 15:19:20.690420 | # Job Information 2025-09-17 15:19:20.690605 | Ansible Version: 2.16.14 2025-09-17 15:19:20.690641 | Job: python-black 2025-09-17 15:19:20.690673 | Pipeline: check 2025-09-17 15:19:20.690695 | Executor: 521e9411259a 2025-09-17 15:19:20.690736 | Triggered by: https://github.com/osism/testbed/pull/2760 2025-09-17 15:19:20.690761 | Event ID: a5447a00-93d9-11f0-8f70-2cc213ba8af9 2025-09-17 15:19:20.699232 | 2025-09-17 15:19:20.700215 | LOOP [emit-job-header : Print node information] 2025-09-17 15:19:21.035767 | debian-bookworm | ok: 2025-09-17 15:19:21.035925 | debian-bookworm | # Node Information 2025-09-17 15:19:21.035969 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-17 15:19:21.035995 | debian-bookworm | Hostname: debian 2025-09-17 15:19:21.036250 | debian-bookworm | Username: zuul 2025-09-17 15:19:21.036272 | debian-bookworm | Distro: Debian 12.12 2025-09-17 15:19:21.036294 | debian-bookworm | Provider: regiocloud-a 2025-09-17 15:19:21.036313 | debian-bookworm | Region: 2025-09-17 15:19:21.036332 | debian-bookworm | Label: debian-bookworm 2025-09-17 15:19:21.036350 | debian-bookworm | Product Name: OpenStack Nova 2025-09-17 15:19:21.036367 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4f:c79f 2025-09-17 15:19:21.060925 | 2025-09-17 15:19:21.061076 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-17 15:19:21.835899 | debian-bookworm -> localhost | changed 2025-09-17 15:19:21.841660 | 2025-09-17 15:19:21.841757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-17 15:19:22.889281 | debian-bookworm -> localhost | changed 2025-09-17 15:19:22.897771 | 2025-09-17 15:19:22.897851 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-17 15:19:23.273724 | debian-bookworm -> localhost | ok 2025-09-17 15:19:23.279886 | 2025-09-17 15:19:23.280000 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-17 15:19:23.311551 | debian-bookworm | ok 2025-09-17 15:19:23.358013 | debian-bookworm | included: /var/lib/zuul/builds/dc57ad116eec4dc8a7135ca0aa2d707e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-17 15:19:23.376290 | 2025-09-17 15:19:23.376396 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-17 15:19:25.122276 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-17 15:19:25.122463 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc57ad116eec4dc8a7135ca0aa2d707e/work/dc57ad116eec4dc8a7135ca0aa2d707e_id_rsa 2025-09-17 15:19:25.122513 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc57ad116eec4dc8a7135ca0aa2d707e/work/dc57ad116eec4dc8a7135ca0aa2d707e_id_rsa.pub 2025-09-17 15:19:25.122549 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-17 15:19:25.122584 | debian-bookworm -> localhost | SHA256:MEVVsLeCInyxkRnw9pcq/T/Y7i7A9DW8YCiG/cFNsVQ zuul-build-sshkey 2025-09-17 15:19:25.122617 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-17 15:19:25.122663 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-17 15:19:25.122687 | debian-bookworm -> localhost | | ....o.==E | 2025-09-17 15:19:25.122708 | debian-bookworm -> localhost | | . = ..o | 2025-09-17 15:19:25.122728 | debian-bookworm -> localhost | | oX. +o.. | 2025-09-17 15:19:25.122748 | debian-bookworm -> localhost | | ...+B=.+o+. | 2025-09-17 15:19:25.122768 | debian-bookworm -> localhost | | o.+=S++o.o | 2025-09-17 15:19:25.122796 | debian-bookworm -> localhost | | o o+o... | 2025-09-17 15:19:25.122818 | debian-bookworm -> localhost | | . o. o | 2025-09-17 15:19:25.122853 | debian-bookworm -> localhost | | . .o o | 2025-09-17 15:19:25.122875 | debian-bookworm -> localhost | | .*=. | 2025-09-17 15:19:25.122895 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-17 15:19:25.122949 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.554100 2025-09-17 15:19:25.128968 | 2025-09-17 15:19:25.129059 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-17 15:19:25.156721 | debian-bookworm | ok 2025-09-17 15:19:25.165472 | debian-bookworm | included: /var/lib/zuul/builds/dc57ad116eec4dc8a7135ca0aa2d707e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-17 15:19:25.192300 | 2025-09-17 15:19:25.192397 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-17 15:19:25.235669 | debian-bookworm | skipping: Conditional result was False 2025-09-17 15:19:25.241335 | 2025-09-17 15:19:25.241430 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-17 15:19:25.950866 | debian-bookworm | changed 2025-09-17 15:19:25.955234 | 2025-09-17 15:19:25.955315 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-17 15:19:26.225089 | debian-bookworm | ok 2025-09-17 15:19:26.229361 | 2025-09-17 15:19:26.229432 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-17 15:19:26.947380 | debian-bookworm | changed 2025-09-17 15:19:26.952667 | 2025-09-17 15:19:26.952747 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-17 15:19:27.638034 | debian-bookworm | changed 2025-09-17 15:19:27.642413 | 2025-09-17 15:19:27.642490 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-17 15:19:27.654862 | debian-bookworm | skipping: Conditional result was False 2025-09-17 15:19:27.660156 | 2025-09-17 15:19:27.660242 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-17 15:19:28.224855 | debian-bookworm -> localhost | changed 2025-09-17 15:19:28.233443 | 2025-09-17 15:19:28.233529 | TASK [add-build-sshkey : Add back temp key] 2025-09-17 15:19:28.783521 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dc57ad116eec4dc8a7135ca0aa2d707e/work/dc57ad116eec4dc8a7135ca0aa2d707e_id_rsa (zuul-build-sshkey) 2025-09-17 15:19:28.783689 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.007677 2025-09-17 15:19:28.789775 | 2025-09-17 15:19:28.789854 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-17 15:19:29.152921 | debian-bookworm | ok 2025-09-17 15:19:29.157586 | 2025-09-17 15:19:29.157670 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-17 15:19:29.180437 | debian-bookworm | skipping: Conditional result was False 2025-09-17 15:19:29.210048 | 2025-09-17 15:19:29.210167 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-17 15:19:29.753373 | debian-bookworm | ok 2025-09-17 15:19:29.763457 | 2025-09-17 15:19:29.763561 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-17 15:19:29.833695 | debian-bookworm | ok 2025-09-17 15:19:29.843446 | 2025-09-17 15:19:29.843538 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-17 15:19:30.350251 | debian-bookworm -> localhost | ok 2025-09-17 15:19:30.356309 | 2025-09-17 15:19:30.356391 | TASK [validate-host : Collect information about the host] 2025-09-17 15:19:31.745531 | debian-bookworm | ok 2025-09-17 15:19:31.761074 | 2025-09-17 15:19:31.761171 | TASK [validate-host : Sanitize hostname] 2025-09-17 15:19:31.842678 | debian-bookworm | ok 2025-09-17 15:19:31.870561 | 2025-09-17 15:19:31.870659 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-17 15:19:32.467862 | debian-bookworm -> localhost | changed 2025-09-17 15:19:32.473206 | 2025-09-17 15:19:32.473301 | TASK [validate-host : Collect information about zuul worker] 2025-09-17 15:19:32.844839 | debian-bookworm | ok 2025-09-17 15:19:32.851985 | 2025-09-17 15:19:32.852082 | TASK [validate-host : Write out all zuul information for each host] 2025-09-17 15:19:33.458028 | debian-bookworm -> localhost | changed 2025-09-17 15:19:33.466865 | 2025-09-17 15:19:33.466957 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-17 15:19:33.749335 | debian-bookworm | ok 2025-09-17 15:19:33.754693 | 2025-09-17 15:19:33.754783 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-17 15:19:35.144010 | debian-bookworm | changed: 2025-09-17 15:19:35.144176 | debian-bookworm | cd+++++++++ src/ 2025-09-17 15:19:35.144210 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-17 15:19:35.144233 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-17 15:19:35.144255 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-17 15:19:35.144274 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012612 2025-09-17 15:20:01.246954 | 2025-09-17 15:20:01.247125 | TASK [upload-logs : Upload logs to log server] 2025-09-17 15:20:01.831270 | localhost | Output suppressed because no_log was given 2025-09-17 15:20:01.833221 | 2025-09-17 15:20:01.833338 | LOOP [upload-logs : Compress console log and json output] 2025-09-17 15:20:01.893501 | localhost | skipping: Conditional result was False 2025-09-17 15:20:01.900108 | localhost | skipping: Conditional result was False 2025-09-17 15:20:01.911189 | 2025-09-17 15:20:01.911333 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-17 15:20:01.962714 | localhost | skipping: Conditional result was False 2025-09-17 15:20:01.963044 | 2025-09-17 15:20:01.969085 | localhost | skipping: Conditional result was False 2025-09-17 15:20:01.978163 | 2025-09-17 15:20:01.978303 | LOOP [upload-logs : Upload console log and json output]