2025-02-04 10:13:17.144508 | Job console starting... 2025-02-04 10:13:17.171950 | Updating repositories 2025-02-04 10:13:17.201399 | Preparing job workspace 2025-02-04 10:13:18.752945 | Running Ansible setup... 2025-02-04 10:13:24.038318 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-04 10:13:24.840491 | 2025-02-04 10:13:24.840699 | PLAY [Base pre] 2025-02-04 10:13:24.886260 | 2025-02-04 10:13:24.886428 | TASK [Setup log path fact] 2025-02-04 10:13:24.908639 | ubuntu-noble | ok 2025-02-04 10:13:24.932809 | 2025-02-04 10:13:24.932987 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 10:13:24.985555 | ubuntu-noble | ok 2025-02-04 10:13:24.998758 | 2025-02-04 10:13:24.998903 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 10:13:25.035995 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:25.043919 | 2025-02-04 10:13:25.044062 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 10:13:25.089062 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:25.097479 | 2025-02-04 10:13:25.097627 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 10:13:25.122590 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:25.139580 | 2025-02-04 10:13:25.139777 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 10:13:25.165103 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:25.175140 | 2025-02-04 10:13:25.175271 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 10:13:25.200688 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:25.216370 | 2025-02-04 10:13:25.216520 | TASK [emit-job-header : Print job information] 2025-02-04 10:13:25.273402 | # Job Information 2025-02-04 10:13:25.273589 | Ansible Version: 2.15.3 2025-02-04 10:13:25.273622 | Job: python-black 2025-02-04 10:13:25.273649 | Pipeline: check 2025-02-04 10:13:25.273708 | Executor: 7d211f194f6a 2025-02-04 10:13:25.273729 | Triggered by: https://github.com/osism/container-images-kolla/pull/547 2025-02-04 10:13:25.273748 | Event ID: a1f5b1c0-e2e0-11ef-9efa-aabb743e9c54 2025-02-04 10:13:25.280285 | 2025-02-04 10:13:25.280930 | LOOP [emit-job-header : Print node information] 2025-02-04 10:13:25.426033 | ubuntu-noble | ok: 2025-02-04 10:13:25.426313 | ubuntu-noble | # Node Information 2025-02-04 10:13:25.426351 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-04 10:13:25.426375 | ubuntu-noble | Hostname: ubuntu 2025-02-04 10:13:25.426396 | ubuntu-noble | Username: zuul 2025-02-04 10:13:25.426415 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-04 10:13:25.426434 | ubuntu-noble | Provider: regiocloud-a 2025-02-04 10:13:25.426453 | ubuntu-noble | Label: ubuntu-noble 2025-02-04 10:13:25.426471 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-04 10:13:25.426491 | ubuntu-noble | Interface IP: 81.163.193.153 2025-02-04 10:13:25.452487 | 2025-02-04 10:13:25.452629 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-04 10:13:25.943281 | ubuntu-noble -> localhost | changed 2025-02-04 10:13:25.952253 | 2025-02-04 10:13:25.952506 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-04 10:13:27.042100 | ubuntu-noble -> localhost | changed 2025-02-04 10:13:27.056830 | 2025-02-04 10:13:27.056961 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-04 10:13:27.367977 | ubuntu-noble -> localhost | ok 2025-02-04 10:13:27.377199 | 2025-02-04 10:13:27.377339 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-04 10:13:27.434187 | ubuntu-noble | ok 2025-02-04 10:13:27.458145 | ubuntu-noble | included: /var/lib/zuul/builds/fa0d588196f94015a6045ff2120bfe43/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-04 10:13:27.467965 | 2025-02-04 10:13:27.468091 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-04 10:13:28.063687 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-04 10:13:28.064033 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/fa0d588196f94015a6045ff2120bfe43/work/fa0d588196f94015a6045ff2120bfe43_id_rsa 2025-02-04 10:13:28.064099 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/fa0d588196f94015a6045ff2120bfe43/work/fa0d588196f94015a6045ff2120bfe43_id_rsa.pub 2025-02-04 10:13:28.064145 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-04 10:13:28.064185 | ubuntu-noble -> localhost | SHA256:jAM9ZejAAspivqF4nsLtz/EWd3DB7AJO36EZKvM3EBY zuul-build-sshkey 2025-02-04 10:13:28.064228 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-04 10:13:28.064274 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-04 10:13:28.064313 | ubuntu-noble -> localhost | |.. . E+ o | 2025-02-04 10:13:28.064349 | ubuntu-noble -> localhost | |o . o..B . = | 2025-02-04 10:13:28.064408 | ubuntu-noble -> localhost | |oo ..o* = * o | 2025-02-04 10:13:28.064447 | ubuntu-noble -> localhost | |+ +.B * + | 2025-02-04 10:13:28.064481 | ubuntu-noble -> localhost | | o * S + | 2025-02-04 10:13:28.064515 | ubuntu-noble -> localhost | |o o + + . | 2025-02-04 10:13:28.064550 | ubuntu-noble -> localhost | |+.o . + o | 2025-02-04 10:13:28.064585 | ubuntu-noble -> localhost | |.+ o. o. | 2025-02-04 10:13:28.064620 | ubuntu-noble -> localhost | | .+..o.. | 2025-02-04 10:13:28.064653 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-04 10:13:28.064800 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.078544 2025-02-04 10:13:28.078458 | 2025-02-04 10:13:28.078613 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-04 10:13:28.128740 | ubuntu-noble | ok 2025-02-04 10:13:28.144866 | ubuntu-noble | included: /var/lib/zuul/builds/fa0d588196f94015a6045ff2120bfe43/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-04 10:13:28.159033 | 2025-02-04 10:13:28.159207 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-04 10:13:28.187416 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:28.201317 | 2025-02-04 10:13:28.201490 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-04 10:13:28.911853 | ubuntu-noble | changed 2025-02-04 10:13:28.921231 | 2025-02-04 10:13:28.921362 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-04 10:13:29.218883 | ubuntu-noble | ok 2025-02-04 10:13:29.228175 | 2025-02-04 10:13:29.228303 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-04 10:13:29.900733 | ubuntu-noble | changed 2025-02-04 10:13:29.912303 | 2025-02-04 10:13:29.912485 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-04 10:13:30.647780 | ubuntu-noble | changed 2025-02-04 10:13:30.664421 | 2025-02-04 10:13:30.664556 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-04 10:13:30.706039 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:30.726841 | 2025-02-04 10:13:30.727016 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-04 10:13:31.162603 | ubuntu-noble -> localhost | changed 2025-02-04 10:13:31.178077 | 2025-02-04 10:13:31.178222 | TASK [add-build-sshkey : Add back temp key] 2025-02-04 10:13:31.509892 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/fa0d588196f94015a6045ff2120bfe43/work/fa0d588196f94015a6045ff2120bfe43_id_rsa (zuul-build-sshkey) 2025-02-04 10:13:31.510223 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008591 2025-02-04 10:13:31.518217 | 2025-02-04 10:13:31.518337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-04 10:13:31.922554 | ubuntu-noble | ok 2025-02-04 10:13:31.967546 | 2025-02-04 10:13:31.967697 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-04 10:13:32.003041 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:13:32.022728 | 2025-02-04 10:13:32.022854 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-04 10:13:32.424755 | ubuntu-noble | ok 2025-02-04 10:13:32.443647 | 2025-02-04 10:13:32.443815 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-04 10:13:32.478014 | ubuntu-noble | ok 2025-02-04 10:13:32.493620 | 2025-02-04 10:13:32.493799 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-04 10:13:32.838322 | ubuntu-noble -> localhost | ok 2025-02-04 10:13:32.846776 | 2025-02-04 10:13:32.846903 | TASK [validate-host : Collect information about the host] 2025-02-04 10:13:34.118249 | ubuntu-noble | ok 2025-02-04 10:13:34.131921 | 2025-02-04 10:13:34.132050 | TASK [validate-host : Sanitize hostname] 2025-02-04 10:13:34.211926 | ubuntu-noble | ok 2025-02-04 10:13:34.222033 | 2025-02-04 10:13:34.222177 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-04 10:13:34.831471 | ubuntu-noble -> localhost | changed 2025-02-04 10:13:34.839432 | 2025-02-04 10:13:34.839553 | TASK [validate-host : Collect information about zuul worker] 2025-02-04 10:13:35.315471 | ubuntu-noble | ok 2025-02-04 10:13:35.323843 | 2025-02-04 10:13:35.323974 | TASK [validate-host : Write out all zuul information for each host] 2025-02-04 10:13:35.930738 | ubuntu-noble -> localhost | changed 2025-02-04 10:13:35.954199 | 2025-02-04 10:13:35.954791 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-04 10:13:36.301202 | ubuntu-noble | ok 2025-02-04 10:13:36.312025 | 2025-02-04 10:13:36.312177 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-04 10:13:37.234335 | ubuntu-noble | changed: 2025-02-04 10:13:37.234537 | ubuntu-noble | cd+++++++++ src/ 2025-02-04 10:13:37.234571 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-04 10:13:37.234595 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-04 10:13:37.234616 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-images-kolla/ 2025-02-04 10:13:37.234637 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.011286 2025-02-04 10:14:08.479349 | 2025-02-04 10:14:08.479460 | TASK [upload-logs : Upload logs to log server] 2025-02-04 10:14:09.133231 | localhost | Output suppressed because no_log was given 2025-02-04 10:14:09.137393 | 2025-02-04 10:14:09.137512 | LOOP [upload-logs : Compress console log and json output] 2025-02-04 10:14:09.214130 | localhost | skipping: Conditional result was False 2025-02-04 10:14:09.237619 | localhost | skipping: Conditional result was False 2025-02-04 10:14:09.249143 | 2025-02-04 10:14:09.249264 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-04 10:14:09.324448 | localhost | skipping: Conditional result was False 2025-02-04 10:14:09.324950 | 2025-02-04 10:14:09.354546 | localhost | skipping: Conditional result was False 2025-02-04 10:14:09.359785 | 2025-02-04 10:14:09.359936 | LOOP [upload-logs : Upload console log and json output]