2025-03-28 08:23:38.497146 | Job console starting... 2025-03-28 08:23:38.534013 | Updating repositories 2025-03-28 08:23:38.573859 | Preparing job workspace 2025-03-28 08:23:40.199170 | Running Ansible setup... 2025-03-28 08:23:45.339034 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-28 08:23:46.042080 | 2025-03-28 08:23:46.042237 | PLAY [Base pre] 2025-03-28 08:23:46.071739 | 2025-03-28 08:23:46.071878 | TASK [Setup log path fact] 2025-03-28 08:23:46.102876 | ubuntu-noble | ok 2025-03-28 08:23:46.122372 | 2025-03-28 08:23:46.122512 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-28 08:23:46.154027 | ubuntu-noble | ok 2025-03-28 08:23:46.169296 | 2025-03-28 08:23:46.169407 | TASK [emit-job-header : Print job information] 2025-03-28 08:23:46.220096 | # Job Information 2025-03-28 08:23:46.220264 | Ansible Version: 2.15.3 2025-03-28 08:23:46.220298 | Job: python-black 2025-03-28 08:23:46.220327 | Pipeline: check 2025-03-28 08:23:46.220347 | Executor: 7d211f194f6a 2025-03-28 08:23:46.220366 | Triggered by: https://github.com/osism/testbed/pull/2648 2025-03-28 08:23:46.220385 | Event ID: ee39d2a0-0bad-11f0-86e8-ebeae9b8b46c 2025-03-28 08:23:46.226972 | 2025-03-28 08:23:46.227083 | LOOP [emit-job-header : Print node information] 2025-03-28 08:23:46.377451 | ubuntu-noble | ok: 2025-03-28 08:23:46.377647 | ubuntu-noble | # Node Information 2025-03-28 08:23:46.377682 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-28 08:23:46.377707 | ubuntu-noble | Hostname: ubuntu 2025-03-28 08:23:46.377729 | ubuntu-noble | Username: zuul 2025-03-28 08:23:46.377749 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-28 08:23:46.377773 | ubuntu-noble | Provider: regiocloud-a 2025-03-28 08:23:46.377794 | ubuntu-noble | Label: ubuntu-noble 2025-03-28 08:23:46.377815 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-28 08:23:46.377835 | ubuntu-noble | Interface IP: 81.163.192.154 2025-03-28 08:23:46.397156 | 2025-03-28 08:23:46.397286 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-28 08:23:46.891960 | ubuntu-noble -> localhost | changed 2025-03-28 08:23:46.902922 | 2025-03-28 08:23:46.903056 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-28 08:23:47.929834 | ubuntu-noble -> localhost | changed 2025-03-28 08:23:47.944724 | 2025-03-28 08:23:47.944850 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-28 08:23:48.209827 | ubuntu-noble -> localhost | ok 2025-03-28 08:23:48.217553 | 2025-03-28 08:23:48.217698 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-28 08:23:48.249392 | ubuntu-noble | ok 2025-03-28 08:23:48.266261 | ubuntu-noble | included: /var/lib/zuul/builds/b7d4cda0d9c449879668e59dbde82b2c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-28 08:23:48.274291 | 2025-03-28 08:23:48.274393 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-28 08:23:48.948963 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-28 08:23:48.949312 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b7d4cda0d9c449879668e59dbde82b2c/work/b7d4cda0d9c449879668e59dbde82b2c_id_rsa 2025-03-28 08:23:48.949383 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b7d4cda0d9c449879668e59dbde82b2c/work/b7d4cda0d9c449879668e59dbde82b2c_id_rsa.pub 2025-03-28 08:23:48.949434 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-28 08:23:48.949484 | ubuntu-noble -> localhost | SHA256:GvWrTKoMLFFJR91fSQj1vWWF80ZBxaPE+gHuxiquBjM zuul-build-sshkey 2025-03-28 08:23:48.949529 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-28 08:23:48.949572 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-28 08:23:48.949628 | ubuntu-noble -> localhost | | ..o. ..o.oo..==| 2025-03-28 08:23:48.949672 | ubuntu-noble -> localhost | | . o . . .oo+o.+| 2025-03-28 08:23:48.949714 | ubuntu-noble -> localhost | | o ....= o++| 2025-03-28 08:23:48.949773 | ubuntu-noble -> localhost | | . . ..o o +o| 2025-03-28 08:23:48.949817 | ubuntu-noble -> localhost | |. . S + . o. | 2025-03-28 08:23:48.949858 | ubuntu-noble -> localhost | | o E o = . | 2025-03-28 08:23:48.949911 | ubuntu-noble -> localhost | |. o + . . + | 2025-03-28 08:23:48.949955 | ubuntu-noble -> localhost | | . o . = o | 2025-03-28 08:23:48.950000 | ubuntu-noble -> localhost | | +o+.+ | 2025-03-28 08:23:48.950043 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-28 08:23:48.950153 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.176490 2025-03-28 08:23:48.963419 | 2025-03-28 08:23:48.963550 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-28 08:23:48.997467 | ubuntu-noble | ok 2025-03-28 08:23:49.010289 | ubuntu-noble | included: /var/lib/zuul/builds/b7d4cda0d9c449879668e59dbde82b2c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-28 08:23:49.020127 | 2025-03-28 08:23:49.020226 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-28 08:23:49.044535 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 08:23:49.051859 | 2025-03-28 08:23:49.051973 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-28 08:23:49.858539 | ubuntu-noble | changed 2025-03-28 08:23:49.874559 | 2025-03-28 08:23:49.874778 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-28 08:23:50.198086 | ubuntu-noble | ok 2025-03-28 08:23:50.205268 | 2025-03-28 08:23:50.205387 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-28 08:23:50.954751 | ubuntu-noble | changed 2025-03-28 08:23:50.964836 | 2025-03-28 08:23:50.964974 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-28 08:23:51.698461 | ubuntu-noble | changed 2025-03-28 08:23:51.706543 | 2025-03-28 08:23:51.706683 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-28 08:23:51.731000 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 08:23:51.738633 | 2025-03-28 08:23:51.738749 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-28 08:23:52.323920 | ubuntu-noble -> localhost | changed 2025-03-28 08:23:52.338265 | 2025-03-28 08:23:52.338401 | TASK [add-build-sshkey : Add back temp key] 2025-03-28 08:23:52.798163 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b7d4cda0d9c449879668e59dbde82b2c/work/b7d4cda0d9c449879668e59dbde82b2c_id_rsa (zuul-build-sshkey) 2025-03-28 08:23:52.798451 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013171 2025-03-28 08:23:52.805706 | 2025-03-28 08:23:52.805810 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-28 08:23:53.273206 | ubuntu-noble | ok 2025-03-28 08:23:53.279942 | 2025-03-28 08:23:53.280045 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-28 08:23:53.313806 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 08:23:53.326502 | 2025-03-28 08:23:53.326598 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-28 08:23:53.797231 | ubuntu-noble | ok 2025-03-28 08:23:53.848414 | 2025-03-28 08:23:53.848542 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-28 08:23:53.879363 | ubuntu-noble | ok 2025-03-28 08:23:53.886365 | 2025-03-28 08:23:53.886478 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-28 08:23:54.198027 | ubuntu-noble -> localhost | ok 2025-03-28 08:23:54.207967 | 2025-03-28 08:23:54.208089 | TASK [validate-host : Collect information about the host] 2025-03-28 08:23:55.496385 | ubuntu-noble | ok 2025-03-28 08:23:55.511506 | 2025-03-28 08:23:55.511637 | TASK [validate-host : Sanitize hostname] 2025-03-28 08:23:55.572981 | ubuntu-noble | ok 2025-03-28 08:23:55.579242 | 2025-03-28 08:23:55.579353 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-28 08:23:56.073853 | ubuntu-noble -> localhost | changed 2025-03-28 08:23:56.081229 | 2025-03-28 08:23:56.081359 | TASK [validate-host : Collect information about zuul worker] 2025-03-28 08:23:56.613329 | ubuntu-noble | ok 2025-03-28 08:23:56.620323 | 2025-03-28 08:23:56.620474 | TASK [validate-host : Write out all zuul information for each host] 2025-03-28 08:23:57.164990 | ubuntu-noble -> localhost | changed 2025-03-28 08:23:57.177947 | 2025-03-28 08:23:57.178066 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-28 08:23:57.510766 | ubuntu-noble | ok 2025-03-28 08:23:57.520905 | 2025-03-28 08:23:57.521053 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-28 08:23:59.054306 | ubuntu-noble | changed: 2025-03-28 08:23:59.054464 | ubuntu-noble | cd+++++++++ src/ 2025-03-28 08:23:59.054498 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-28 08:23:59.054522 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-28 08:23:59.054543 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-28 08:23:59.054562 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.003884 2025-03-28 08:24:31.756573 | 2025-03-28 08:24:31.756713 | TASK [upload-logs : Upload logs to log server] 2025-03-28 08:24:32.328118 | localhost | Output suppressed because no_log was given 2025-03-28 08:24:32.335114 | 2025-03-28 08:24:32.335283 | LOOP [upload-logs : Compress console log and json output] 2025-03-28 08:24:32.402745 | localhost | skipping: Conditional result was False 2025-03-28 08:24:32.420049 | localhost | skipping: Conditional result was False 2025-03-28 08:24:32.433330 | 2025-03-28 08:24:32.433527 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-28 08:24:32.504172 | localhost | skipping: Conditional result was False 2025-03-28 08:24:32.504514 | 2025-03-28 08:24:32.517722 | localhost | skipping: Conditional result was False 2025-03-28 08:24:32.524790 | 2025-03-28 08:24:32.524910 | LOOP [upload-logs : Upload console log and json output]