2025-04-22 03:16:30.179440 | Job console starting... 2025-04-22 03:16:30.195848 | Updating repositories 2025-04-22 03:16:30.217387 | Preparing job workspace 2025-04-22 03:16:31.323336 | Running Ansible setup... 2025-04-22 03:16:36.456425 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-22 03:16:37.249284 | 2025-04-22 03:16:37.249786 | PLAY [Base pre] 2025-04-22 03:16:37.282408 | 2025-04-22 03:16:37.282555 | TASK [Setup log path fact] 2025-04-22 03:16:37.306926 | ubuntu-noble | ok 2025-04-22 03:16:37.328379 | 2025-04-22 03:16:37.328550 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-22 03:16:37.359652 | ubuntu-noble | ok 2025-04-22 03:16:37.373603 | 2025-04-22 03:16:37.373721 | TASK [emit-job-header : Print job information] 2025-04-22 03:16:37.426094 | # Job Information 2025-04-22 03:16:37.426290 | Ansible Version: 2.15.3 2025-04-22 03:16:37.426326 | Job: python-black 2025-04-22 03:16:37.426357 | Pipeline: periodic-daily 2025-04-22 03:16:37.426377 | Executor: 7d211f194f6a 2025-04-22 03:16:37.426396 | Triggered by: https://github.com/osism/testbed 2025-04-22 03:16:37.426415 | Event ID: 041e679d884d4cbb90dc286715940623 2025-04-22 03:16:37.433386 | 2025-04-22 03:16:37.433498 | LOOP [emit-job-header : Print node information] 2025-04-22 03:16:37.598483 | ubuntu-noble | ok: 2025-04-22 03:16:37.598921 | ubuntu-noble | # Node Information 2025-04-22 03:16:37.598986 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-22 03:16:37.599027 | ubuntu-noble | Hostname: ubuntu 2025-04-22 03:16:37.599063 | ubuntu-noble | Username: zuul 2025-04-22 03:16:37.599096 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-22 03:16:37.599136 | ubuntu-noble | Provider: regiocloud-a 2025-04-22 03:16:37.599170 | ubuntu-noble | Label: ubuntu-noble 2025-04-22 03:16:37.599205 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-22 03:16:37.599260 | ubuntu-noble | Interface IP: 81.163.193.40 2025-04-22 03:16:37.632634 | 2025-04-22 03:16:37.632785 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-22 03:16:38.127369 | ubuntu-noble -> localhost | changed 2025-04-22 03:16:38.135910 | 2025-04-22 03:16:38.136012 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-22 03:16:39.080793 | ubuntu-noble -> localhost | changed 2025-04-22 03:16:39.095835 | 2025-04-22 03:16:39.095935 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-22 03:16:39.455311 | ubuntu-noble -> localhost | ok 2025-04-22 03:16:39.463188 | 2025-04-22 03:16:39.463299 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-22 03:16:39.493284 | ubuntu-noble | ok 2025-04-22 03:16:39.508996 | ubuntu-noble | included: /var/lib/zuul/builds/6a3e9fe1e1a145c3993d4435039b1a01/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-22 03:16:39.526756 | 2025-04-22 03:16:39.527109 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-22 03:16:40.480137 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-22 03:16:40.480377 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/6a3e9fe1e1a145c3993d4435039b1a01/work/6a3e9fe1e1a145c3993d4435039b1a01_id_rsa 2025-04-22 03:16:40.480442 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/6a3e9fe1e1a145c3993d4435039b1a01/work/6a3e9fe1e1a145c3993d4435039b1a01_id_rsa.pub 2025-04-22 03:16:40.480474 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-22 03:16:40.480501 | ubuntu-noble -> localhost | SHA256:lnFRN28LWFNzvB8KskCcQG/To+yEd5Kv9VINwWrRclM zuul-build-sshkey 2025-04-22 03:16:40.480527 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-22 03:16:40.480551 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-22 03:16:40.480596 | ubuntu-noble -> localhost | | .oo . +.oE++.| 2025-04-22 03:16:40.480623 | ubuntu-noble -> localhost | | .+.o Bo..o+| 2025-04-22 03:16:40.480646 | ubuntu-noble -> localhost | | .+.o*.o. +| 2025-04-22 03:16:40.480681 | ubuntu-noble -> localhost | | +.+B.o .+.| 2025-04-22 03:16:40.480706 | ubuntu-noble -> localhost | | . BS.o + ..o| 2025-04-22 03:16:40.480730 | ubuntu-noble -> localhost | | +.+. . o .| 2025-04-22 03:16:40.480762 | ubuntu-noble -> localhost | | . o. | 2025-04-22 03:16:40.480788 | ubuntu-noble -> localhost | | o.. | 2025-04-22 03:16:40.480812 | ubuntu-noble -> localhost | | . .. | 2025-04-22 03:16:40.480836 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-22 03:16:40.480896 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.499096 2025-04-22 03:16:40.489651 | 2025-04-22 03:16:40.489900 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-22 03:16:40.519392 | ubuntu-noble | ok 2025-04-22 03:16:40.532489 | ubuntu-noble | included: /var/lib/zuul/builds/6a3e9fe1e1a145c3993d4435039b1a01/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-22 03:16:40.546030 | 2025-04-22 03:16:40.546125 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-22 03:16:40.595938 | ubuntu-noble | skipping: Conditional result was False 2025-04-22 03:16:40.603581 | 2025-04-22 03:16:40.603699 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-22 03:16:41.317813 | ubuntu-noble | changed 2025-04-22 03:16:41.326599 | 2025-04-22 03:16:41.326697 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-22 03:16:41.621902 | ubuntu-noble | ok 2025-04-22 03:16:41.632722 | 2025-04-22 03:16:41.632844 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-22 03:16:42.380209 | ubuntu-noble | changed 2025-04-22 03:16:42.386899 | 2025-04-22 03:16:42.386986 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-22 03:16:43.121477 | ubuntu-noble | changed 2025-04-22 03:16:43.128277 | 2025-04-22 03:16:43.128365 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-22 03:16:43.151867 | ubuntu-noble | skipping: Conditional result was False 2025-04-22 03:16:43.159897 | 2025-04-22 03:16:43.159991 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-22 03:16:43.548451 | ubuntu-noble -> localhost | changed 2025-04-22 03:16:43.575029 | 2025-04-22 03:16:43.575311 | TASK [add-build-sshkey : Add back temp key] 2025-04-22 03:16:43.902364 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/6a3e9fe1e1a145c3993d4435039b1a01/work/6a3e9fe1e1a145c3993d4435039b1a01_id_rsa (zuul-build-sshkey) 2025-04-22 03:16:43.902551 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015784 2025-04-22 03:16:43.910491 | 2025-04-22 03:16:43.910584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-22 03:16:44.274168 | ubuntu-noble | ok 2025-04-22 03:16:44.283055 | 2025-04-22 03:16:44.283158 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-22 03:16:44.317970 | ubuntu-noble | skipping: Conditional result was False 2025-04-22 03:16:44.344365 | 2025-04-22 03:16:44.344496 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-22 03:16:44.784996 | ubuntu-noble | ok 2025-04-22 03:16:44.819367 | 2025-04-22 03:16:44.819465 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-22 03:16:44.867566 | ubuntu-noble | ok 2025-04-22 03:16:44.877056 | 2025-04-22 03:16:44.877162 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-22 03:16:45.124560 | ubuntu-noble -> localhost | ok 2025-04-22 03:16:45.141946 | 2025-04-22 03:16:45.142082 | TASK [validate-host : Collect information about the host] 2025-04-22 03:16:46.268485 | ubuntu-noble | ok 2025-04-22 03:16:46.287263 | 2025-04-22 03:16:46.287377 | TASK [validate-host : Sanitize hostname] 2025-04-22 03:16:46.374715 | ubuntu-noble | ok 2025-04-22 03:16:46.388314 | 2025-04-22 03:16:46.388728 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-22 03:16:47.236684 | ubuntu-noble -> localhost | changed 2025-04-22 03:16:47.255162 | 2025-04-22 03:16:47.255393 | TASK [validate-host : Collect information about zuul worker] 2025-04-22 03:16:47.851016 | ubuntu-noble | ok 2025-04-22 03:16:47.858425 | 2025-04-22 03:16:47.858559 | TASK [validate-host : Write out all zuul information for each host] 2025-04-22 03:16:48.649417 | ubuntu-noble -> localhost | changed 2025-04-22 03:16:48.687079 | 2025-04-22 03:16:48.687233 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-22 03:16:49.053393 | ubuntu-noble | ok 2025-04-22 03:16:49.067852 | 2025-04-22 03:16:49.067987 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-22 03:16:50.512031 | ubuntu-noble | changed: 2025-04-22 03:16:50.512261 | ubuntu-noble | cd+++++++++ src/ 2025-04-22 03:16:50.512300 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-22 03:16:50.512326 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-22 03:16:50.512347 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-22 03:16:50.512366 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006619 2025-04-22 03:17:24.594283 | 2025-04-22 03:17:24.594366 | TASK [upload-logs : Upload logs to log server] 2025-04-22 03:17:25.559994 | localhost | Output suppressed because no_log was given 2025-04-22 03:17:25.562964 | 2025-04-22 03:17:25.563058 | LOOP [upload-logs : Compress console log and json output] 2025-04-22 03:17:25.694046 | localhost | skipping: Conditional result was False 2025-04-22 03:17:25.717317 | localhost | skipping: Conditional result was False 2025-04-22 03:17:25.722732 | 2025-04-22 03:17:25.722853 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-22 03:17:25.877161 | localhost | skipping: Conditional result was False 2025-04-22 03:17:25.877421 | 2025-04-22 03:17:25.900012 | localhost | skipping: Conditional result was False 2025-04-22 03:17:25.907671 | 2025-04-22 03:17:25.907992 | LOOP [upload-logs : Upload console log and json output]