2025-04-08 00:07:31.015907 | Job console starting... 2025-04-08 00:07:31.023710 | Updating repositories 2025-04-08 00:07:31.062523 | Preparing job workspace 2025-04-08 00:07:32.693999 | Running Ansible setup... 2025-04-08 00:07:37.748369 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-08 00:07:38.464309 | 2025-04-08 00:07:38.464549 | PLAY [Base pre] 2025-04-08 00:07:38.498880 | 2025-04-08 00:07:38.499013 | TASK [Setup log path fact] 2025-04-08 00:07:38.522200 | ubuntu-noble | ok 2025-04-08 00:07:38.540758 | 2025-04-08 00:07:38.540883 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-08 00:07:38.571187 | ubuntu-noble | ok 2025-04-08 00:07:38.587147 | 2025-04-08 00:07:38.587250 | TASK [emit-job-header : Print job information] 2025-04-08 00:07:38.644449 | # Job Information 2025-04-08 00:07:38.644686 | Ansible Version: 2.15.3 2025-04-08 00:07:38.644722 | Job: python-black 2025-04-08 00:07:38.644897 | Pipeline: check 2025-04-08 00:07:38.644932 | Executor: 7d211f194f6a 2025-04-08 00:07:38.644953 | Triggered by: https://github.com/osism/testbed/pull/2659 2025-04-08 00:07:38.644974 | Event ID: 56fda840-140d-11f0-96e4-c7d839150617 2025-04-08 00:07:38.654654 | 2025-04-08 00:07:38.654915 | LOOP [emit-job-header : Print node information] 2025-04-08 00:07:38.804701 | ubuntu-noble | ok: 2025-04-08 00:07:38.804904 | ubuntu-noble | # Node Information 2025-04-08 00:07:38.804940 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-08 00:07:38.804966 | ubuntu-noble | Hostname: ubuntu 2025-04-08 00:07:38.804988 | ubuntu-noble | Username: zuul 2025-04-08 00:07:38.805009 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-08 00:07:38.805034 | ubuntu-noble | Provider: regiocloud-a 2025-04-08 00:07:38.805055 | ubuntu-noble | Label: ubuntu-noble 2025-04-08 00:07:38.805076 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-08 00:07:38.805097 | ubuntu-noble | Interface IP: 81.163.193.91 2025-04-08 00:07:38.839875 | 2025-04-08 00:07:38.840044 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-08 00:07:39.381806 | ubuntu-noble -> localhost | changed 2025-04-08 00:07:39.393450 | 2025-04-08 00:07:39.393577 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-08 00:07:40.718655 | ubuntu-noble -> localhost | changed 2025-04-08 00:07:40.736427 | 2025-04-08 00:07:40.736594 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-08 00:07:41.070202 | ubuntu-noble -> localhost | ok 2025-04-08 00:07:41.078608 | 2025-04-08 00:07:41.078759 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-08 00:07:41.117454 | ubuntu-noble | ok 2025-04-08 00:07:41.166313 | ubuntu-noble | included: /var/lib/zuul/builds/d13de8ec59a1497c902a603b25e350bf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-08 00:07:41.176463 | 2025-04-08 00:07:41.176583 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-08 00:07:42.098545 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-08 00:07:42.098802 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d13de8ec59a1497c902a603b25e350bf/work/d13de8ec59a1497c902a603b25e350bf_id_rsa 2025-04-08 00:07:42.098859 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d13de8ec59a1497c902a603b25e350bf/work/d13de8ec59a1497c902a603b25e350bf_id_rsa.pub 2025-04-08 00:07:42.098901 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-08 00:07:42.098941 | ubuntu-noble -> localhost | SHA256:2Z2wovLYZ6qRzKjDcQW0sw+xRoYmerZ5T+Jw/MllmK8 zuul-build-sshkey 2025-04-08 00:07:42.098978 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-08 00:07:42.099013 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-08 00:07:42.099047 | ubuntu-noble -> localhost | | .. | 2025-04-08 00:07:42.099080 | ubuntu-noble -> localhost | | ... | 2025-04-08 00:07:42.099112 | ubuntu-noble -> localhost | |.o *. . | 2025-04-08 00:07:42.099158 | ubuntu-noble -> localhost | |+ o =. o + . | 2025-04-08 00:07:42.099192 | ubuntu-noble -> localhost | |. o=. S o o | 2025-04-08 00:07:42.099223 | ubuntu-noble -> localhost | | +.Oo. + . | 2025-04-08 00:07:42.099263 | ubuntu-noble -> localhost | |. B @.= o | 2025-04-08 00:07:42.099295 | ubuntu-noble -> localhost | |.o = % =o | 2025-04-08 00:07:42.099345 | ubuntu-noble -> localhost | |.. +.E=. | 2025-04-08 00:07:42.099380 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-08 00:07:42.099457 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.245813 2025-04-08 00:07:42.111839 | 2025-04-08 00:07:42.111965 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-08 00:07:42.147584 | ubuntu-noble | ok 2025-04-08 00:07:42.164136 | ubuntu-noble | included: /var/lib/zuul/builds/d13de8ec59a1497c902a603b25e350bf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-08 00:07:42.173550 | 2025-04-08 00:07:42.173740 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-08 00:07:42.207775 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 00:07:42.217361 | 2025-04-08 00:07:42.217461 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-08 00:07:43.119227 | ubuntu-noble | changed 2025-04-08 00:07:43.129226 | 2025-04-08 00:07:43.129394 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-08 00:07:43.500731 | ubuntu-noble | ok 2025-04-08 00:07:43.507983 | 2025-04-08 00:07:43.508070 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-08 00:07:44.246524 | ubuntu-noble | changed 2025-04-08 00:07:44.255430 | 2025-04-08 00:07:44.255532 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-08 00:07:44.993833 | ubuntu-noble | changed 2025-04-08 00:07:45.004296 | 2025-04-08 00:07:45.004466 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-08 00:07:45.031163 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 00:07:45.046140 | 2025-04-08 00:07:45.046279 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-08 00:07:45.492111 | ubuntu-noble -> localhost | changed 2025-04-08 00:07:45.513399 | 2025-04-08 00:07:45.513551 | TASK [add-build-sshkey : Add back temp key] 2025-04-08 00:07:45.835743 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d13de8ec59a1497c902a603b25e350bf/work/d13de8ec59a1497c902a603b25e350bf_id_rsa (zuul-build-sshkey) 2025-04-08 00:07:45.835969 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017273 2025-04-08 00:07:45.843505 | 2025-04-08 00:07:45.843587 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-08 00:07:46.282679 | ubuntu-noble | ok 2025-04-08 00:07:46.289438 | 2025-04-08 00:07:46.289528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-08 00:07:46.333652 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 00:07:46.357430 | 2025-04-08 00:07:46.357616 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-08 00:07:46.879980 | ubuntu-noble | ok 2025-04-08 00:07:46.891703 | 2025-04-08 00:07:46.891786 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-08 00:07:46.941774 | ubuntu-noble | ok 2025-04-08 00:07:46.951800 | 2025-04-08 00:07:46.951924 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-08 00:07:47.273101 | ubuntu-noble -> localhost | ok 2025-04-08 00:07:47.281982 | 2025-04-08 00:07:47.282065 | TASK [validate-host : Collect information about the host] 2025-04-08 00:07:48.539678 | ubuntu-noble | ok 2025-04-08 00:07:48.556733 | 2025-04-08 00:07:48.556932 | TASK [validate-host : Sanitize hostname] 2025-04-08 00:07:48.638984 | ubuntu-noble | ok 2025-04-08 00:07:48.646402 | 2025-04-08 00:07:48.646530 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-08 00:07:49.235385 | ubuntu-noble -> localhost | changed 2025-04-08 00:07:49.246090 | 2025-04-08 00:07:49.246219 | TASK [validate-host : Collect information about zuul worker] 2025-04-08 00:07:49.961031 | ubuntu-noble | ok 2025-04-08 00:07:49.969112 | 2025-04-08 00:07:49.969229 | TASK [validate-host : Write out all zuul information for each host] 2025-04-08 00:07:50.600615 | ubuntu-noble -> localhost | changed 2025-04-08 00:07:50.631116 | 2025-04-08 00:07:50.631354 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-08 00:07:50.981244 | ubuntu-noble | ok 2025-04-08 00:07:50.991752 | 2025-04-08 00:07:50.992016 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-08 00:07:52.554565 | ubuntu-noble | changed: 2025-04-08 00:07:52.554761 | ubuntu-noble | cd+++++++++ src/ 2025-04-08 00:07:52.554875 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-08 00:07:52.554905 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-08 00:07:52.554927 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-08 00:07:52.554948 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009311 2025-04-08 00:08:29.199583 | 2025-04-08 00:08:29.199761 | TASK [upload-logs : Upload logs to log server] 2025-04-08 00:08:29.788415 | localhost | Output suppressed because no_log was given 2025-04-08 00:08:29.796069 | 2025-04-08 00:08:29.796314 | LOOP [upload-logs : Compress console log and json output] 2025-04-08 00:08:29.872368 | localhost | skipping: Conditional result was False 2025-04-08 00:08:29.906643 | localhost | skipping: Conditional result was False 2025-04-08 00:08:29.919551 | 2025-04-08 00:08:29.919702 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-08 00:08:29.992897 | localhost | skipping: Conditional result was False 2025-04-08 00:08:29.993205 | 2025-04-08 00:08:30.021353 | localhost | skipping: Conditional result was False 2025-04-08 00:08:30.036128 | 2025-04-08 00:08:30.036325 | LOOP [upload-logs : Upload console log and json output]