2025-02-25 23:09:27.132102 | Job console starting... 2025-02-25 23:09:27.170884 | Updating repositories 2025-02-25 23:09:27.222216 | Preparing job workspace 2025-02-25 23:09:29.121664 | Running Ansible setup... 2025-02-25 23:09:34.708572 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 23:09:35.433238 | 2025-02-25 23:09:35.433402 | PLAY [Base pre] 2025-02-25 23:09:35.464678 | 2025-02-25 23:09:35.464832 | TASK [Setup log path fact] 2025-02-25 23:09:35.500371 | ubuntu-noble | ok 2025-02-25 23:09:35.547779 | 2025-02-25 23:09:35.547941 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:09:35.613422 | ubuntu-noble | ok 2025-02-25 23:09:35.620975 | 2025-02-25 23:09:35.621099 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:09:35.688795 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:35.696216 | 2025-02-25 23:09:35.696348 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:09:35.784730 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:35.792950 | 2025-02-25 23:09:35.793085 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:09:35.841387 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:35.850723 | 2025-02-25 23:09:35.850857 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:09:35.886045 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:35.896951 | 2025-02-25 23:09:35.897090 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:09:35.942131 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:35.959281 | 2025-02-25 23:09:35.959410 | TASK [emit-job-header : Print job information] 2025-02-25 23:09:36.021784 | # Job Information 2025-02-25 23:09:36.021971 | Ansible Version: 2.15.3 2025-02-25 23:09:36.022004 | Job: python-black 2025-02-25 23:09:36.022033 | Pipeline: check 2025-02-25 23:09:36.022054 | Executor: 7d211f194f6a 2025-02-25 23:09:36.022072 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1770 2025-02-25 23:09:36.022090 | Event ID: c7023a10-f3ca-11ef-8eb9-61836ec52c1e 2025-02-25 23:09:36.028323 | 2025-02-25 23:09:36.028463 | LOOP [emit-job-header : Print node information] 2025-02-25 23:09:36.174113 | ubuntu-noble | ok: 2025-02-25 23:09:36.174317 | ubuntu-noble | # Node Information 2025-02-25 23:09:36.174351 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 23:09:36.174374 | ubuntu-noble | Hostname: ubuntu 2025-02-25 23:09:36.174395 | ubuntu-noble | Username: zuul 2025-02-25 23:09:36.174415 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 23:09:36.174433 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 23:09:36.174452 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 23:09:36.174471 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 23:09:36.174527 | ubuntu-noble | Interface IP: 81.163.193.163 2025-02-25 23:09:36.208816 | 2025-02-25 23:09:36.208978 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 23:09:36.697536 | ubuntu-noble -> localhost | changed 2025-02-25 23:09:36.706411 | 2025-02-25 23:09:36.706563 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 23:09:37.884549 | ubuntu-noble -> localhost | changed 2025-02-25 23:09:37.900776 | 2025-02-25 23:09:37.900898 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 23:09:38.180040 | ubuntu-noble -> localhost | ok 2025-02-25 23:09:38.188531 | 2025-02-25 23:09:38.188650 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 23:09:38.219414 | ubuntu-noble | ok 2025-02-25 23:09:38.236456 | ubuntu-noble | included: /var/lib/zuul/builds/09f00afcd38247cf9fce03e9269b2257/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 23:09:38.244653 | 2025-02-25 23:09:38.244763 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 23:09:39.280532 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 23:09:39.280767 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/09f00afcd38247cf9fce03e9269b2257/work/09f00afcd38247cf9fce03e9269b2257_id_rsa 2025-02-25 23:09:39.280804 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/09f00afcd38247cf9fce03e9269b2257/work/09f00afcd38247cf9fce03e9269b2257_id_rsa.pub 2025-02-25 23:09:39.280829 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 23:09:39.280851 | ubuntu-noble -> localhost | SHA256:YLJn67/EZzNwMCXltC3d07jZDxDaOEGx8Dq9K30x3OI zuul-build-sshkey 2025-02-25 23:09:39.280874 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 23:09:39.280899 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 23:09:39.280920 | ubuntu-noble -> localhost | | ooB.. | 2025-02-25 23:09:39.280940 | ubuntu-noble -> localhost | | B X o o | 2025-02-25 23:09:39.280959 | ubuntu-noble -> localhost | | . o o X = + .| 2025-02-25 23:09:39.280978 | ubuntu-noble -> localhost | | + . = o . = | 2025-02-25 23:09:39.280997 | ubuntu-noble -> localhost | | . o S o. .+ .| 2025-02-25 23:09:39.281015 | ubuntu-noble -> localhost | | o o + .= ...| 2025-02-25 23:09:39.281034 | ubuntu-noble -> localhost | | . o.*. + .| 2025-02-25 23:09:39.281052 | ubuntu-noble -> localhost | | . ..o.+E | 2025-02-25 23:09:39.281071 | ubuntu-noble -> localhost | | ..oo.. | 2025-02-25 23:09:39.281090 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 23:09:39.281144 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.506244 2025-02-25 23:09:39.288895 | 2025-02-25 23:09:39.289011 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 23:09:39.321356 | ubuntu-noble | ok 2025-02-25 23:09:39.332841 | ubuntu-noble | included: /var/lib/zuul/builds/09f00afcd38247cf9fce03e9269b2257/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 23:09:39.343022 | 2025-02-25 23:09:39.343124 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 23:09:39.368108 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:39.375757 | 2025-02-25 23:09:39.375874 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 23:09:40.059983 | ubuntu-noble | changed 2025-02-25 23:09:40.071388 | 2025-02-25 23:09:40.071536 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 23:09:40.348078 | ubuntu-noble | ok 2025-02-25 23:09:40.357362 | 2025-02-25 23:09:40.357531 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 23:09:41.074636 | ubuntu-noble | changed 2025-02-25 23:09:41.086941 | 2025-02-25 23:09:41.087077 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 23:09:41.734973 | ubuntu-noble | changed 2025-02-25 23:09:41.742365 | 2025-02-25 23:09:41.742497 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 23:09:41.767063 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:41.774840 | 2025-02-25 23:09:41.774958 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 23:09:42.508809 | ubuntu-noble -> localhost | changed 2025-02-25 23:09:42.532098 | 2025-02-25 23:09:42.532241 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 23:09:43.404261 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/09f00afcd38247cf9fce03e9269b2257/work/09f00afcd38247cf9fce03e9269b2257_id_rsa (zuul-build-sshkey) 2025-02-25 23:09:43.404526 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.028786 2025-02-25 23:09:43.411539 | 2025-02-25 23:09:43.411648 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 23:09:43.783691 | ubuntu-noble | ok 2025-02-25 23:09:43.790575 | 2025-02-25 23:09:43.790691 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 23:09:43.825306 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:09:43.838887 | 2025-02-25 23:09:43.839005 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 23:09:44.262117 | ubuntu-noble | ok 2025-02-25 23:09:44.274845 | 2025-02-25 23:09:44.274982 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 23:09:44.305985 | ubuntu-noble | ok 2025-02-25 23:09:44.312751 | 2025-02-25 23:09:44.312865 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 23:09:44.613441 | ubuntu-noble -> localhost | ok 2025-02-25 23:09:44.621472 | 2025-02-25 23:09:44.621629 | TASK [validate-host : Collect information about the host] 2025-02-25 23:09:45.828548 | ubuntu-noble | ok 2025-02-25 23:09:45.854255 | 2025-02-25 23:09:45.854371 | TASK [validate-host : Sanitize hostname] 2025-02-25 23:09:45.959558 | ubuntu-noble | ok 2025-02-25 23:09:45.973280 | 2025-02-25 23:09:45.973391 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 23:09:46.499158 | ubuntu-noble -> localhost | changed 2025-02-25 23:09:46.505897 | 2025-02-25 23:09:46.505986 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 23:09:47.004705 | ubuntu-noble | ok 2025-02-25 23:09:47.011232 | 2025-02-25 23:09:47.011348 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 23:09:47.704003 | ubuntu-noble -> localhost | changed 2025-02-25 23:09:47.717469 | 2025-02-25 23:09:47.717649 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 23:09:48.058271 | ubuntu-noble | ok 2025-02-25 23:09:48.065509 | 2025-02-25 23:09:48.065617 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 23:09:49.322236 | ubuntu-noble | changed: 2025-02-25 23:09:49.322569 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 23:09:49.322617 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 23:09:49.322778 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 23:09:49.322813 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-25 23:09:49.322837 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006983 2025-02-25 23:10:23.482643 | 2025-02-25 23:10:23.482794 | TASK [upload-logs : Upload logs to log server] 2025-02-25 23:10:24.073208 | localhost | Output suppressed because no_log was given 2025-02-25 23:10:24.078005 | 2025-02-25 23:10:24.078142 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 23:10:24.154166 | localhost | skipping: Conditional result was False 2025-02-25 23:10:24.171293 | localhost | skipping: Conditional result was False 2025-02-25 23:10:24.184956 | 2025-02-25 23:10:24.185142 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 23:10:24.267239 | localhost | skipping: Conditional result was False 2025-02-25 23:10:24.267917 | 2025-02-25 23:10:24.290087 | localhost | skipping: Conditional result was False 2025-02-25 23:10:24.302346 | 2025-02-25 23:10:24.302637 | LOOP [upload-logs : Upload console log and json output]