2025-05-02 00:07:02.205269 | Job console starting... 2025-05-02 00:07:02.268114 | Updating repositories 2025-05-02 00:07:02.298372 | Preparing job workspace 2025-05-02 00:07:04.140445 | Running Ansible setup... 2025-05-02 00:07:10.645152 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-02 00:07:11.754609 | 2025-05-02 00:07:11.754747 | PLAY [Base pre] 2025-05-02 00:07:11.829656 | 2025-05-02 00:07:11.829787 | TASK [Setup log path fact] 2025-05-02 00:07:11.890498 | ubuntu-noble | ok 2025-05-02 00:07:11.925178 | 2025-05-02 00:07:11.925334 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-02 00:07:11.975414 | ubuntu-noble | ok 2025-05-02 00:07:11.987720 | 2025-05-02 00:07:11.987825 | TASK [emit-job-header : Print job information] 2025-05-02 00:07:12.059755 | # Job Information 2025-05-02 00:07:12.059909 | Ansible Version: 2.15.3 2025-05-02 00:07:12.059943 | Job: python-black 2025-05-02 00:07:12.059971 | Pipeline: check 2025-05-02 00:07:12.059992 | Executor: 7d211f194f6a 2025-05-02 00:07:12.060011 | Triggered by: https://github.com/osism/testbed/pull/2660 2025-05-02 00:07:12.060030 | Event ID: 5aab5a20-26e9-11f0-9257-e6e1e3e12646 2025-05-02 00:07:12.066284 | 2025-05-02 00:07:12.066380 | LOOP [emit-job-header : Print node information] 2025-05-02 00:07:12.213168 | ubuntu-noble | ok: 2025-05-02 00:07:12.213377 | ubuntu-noble | # Node Information 2025-05-02 00:07:12.213410 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-02 00:07:12.213431 | ubuntu-noble | Hostname: ubuntu 2025-05-02 00:07:12.213448 | ubuntu-noble | Username: zuul 2025-05-02 00:07:12.213465 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-02 00:07:12.213484 | ubuntu-noble | Provider: regiocloud-a 2025-05-02 00:07:12.213501 | ubuntu-noble | Label: ubuntu-noble 2025-05-02 00:07:12.213518 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-02 00:07:12.213534 | ubuntu-noble | Interface IP: 81.163.192.194 2025-05-02 00:07:12.243884 | 2025-05-02 00:07:12.244009 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-02 00:07:12.902635 | ubuntu-noble -> localhost | changed 2025-05-02 00:07:12.911033 | 2025-05-02 00:07:12.911136 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-02 00:07:14.251061 | ubuntu-noble -> localhost | changed 2025-05-02 00:07:14.280298 | 2025-05-02 00:07:14.280486 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-02 00:07:14.688819 | ubuntu-noble -> localhost | ok 2025-05-02 00:07:14.695166 | 2025-05-02 00:07:14.695257 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-02 00:07:14.735634 | ubuntu-noble | ok 2025-05-02 00:07:14.756123 | ubuntu-noble | included: /var/lib/zuul/builds/251f02d7506547999eddef8449c59e93/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-02 00:07:14.768355 | 2025-05-02 00:07:14.768469 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-02 00:07:15.365349 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-02 00:07:15.365529 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/251f02d7506547999eddef8449c59e93/work/251f02d7506547999eddef8449c59e93_id_rsa 2025-05-02 00:07:15.365559 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/251f02d7506547999eddef8449c59e93/work/251f02d7506547999eddef8449c59e93_id_rsa.pub 2025-05-02 00:07:15.365580 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-02 00:07:15.365598 | ubuntu-noble -> localhost | SHA256:/INhY3KtTmV+NMZHgUt7QLqpbCgvEhUK6V4ovMCKYnw zuul-build-sshkey 2025-05-02 00:07:15.365616 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-02 00:07:15.365633 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-02 00:07:15.365650 | ubuntu-noble -> localhost | | . .... | 2025-05-02 00:07:15.365666 | ubuntu-noble -> localhost | |o . .+ . | 2025-05-02 00:07:15.365681 | ubuntu-noble -> localhost | |+... . .. +. | 2025-05-02 00:07:15.365703 | ubuntu-noble -> localhost | |o=... . . +o.. | 2025-05-02 00:07:15.365720 | ubuntu-noble -> localhost | |B o. . S * =.. | 2025-05-02 00:07:15.365736 | ubuntu-noble -> localhost | |+=.E B @ o o | 2025-05-02 00:07:15.365756 | ubuntu-noble -> localhost | |o ... . B + . | 2025-05-02 00:07:15.365773 | ubuntu-noble -> localhost | | . .o + o | 2025-05-02 00:07:15.365789 | ubuntu-noble -> localhost | | . .. . | 2025-05-02 00:07:15.365805 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-02 00:07:15.365845 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.044616 2025-05-02 00:07:15.374560 | 2025-05-02 00:07:15.374655 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-02 00:07:15.438745 | ubuntu-noble | ok 2025-05-02 00:07:15.449239 | ubuntu-noble | included: /var/lib/zuul/builds/251f02d7506547999eddef8449c59e93/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-02 00:07:15.457203 | 2025-05-02 00:07:15.457308 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-02 00:07:15.481846 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 00:07:15.488152 | 2025-05-02 00:07:15.488243 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-02 00:07:16.246393 | ubuntu-noble | changed 2025-05-02 00:07:16.258871 | 2025-05-02 00:07:16.259028 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-02 00:07:16.564272 | ubuntu-noble | ok 2025-05-02 00:07:16.574008 | 2025-05-02 00:07:16.574111 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-02 00:07:17.240930 | ubuntu-noble | changed 2025-05-02 00:07:17.252223 | 2025-05-02 00:07:17.252322 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-02 00:07:17.979779 | ubuntu-noble | changed 2025-05-02 00:07:18.000364 | 2025-05-02 00:07:18.000672 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-02 00:07:18.033633 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 00:07:18.040876 | 2025-05-02 00:07:18.040975 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-02 00:07:18.461952 | ubuntu-noble -> localhost | changed 2025-05-02 00:07:18.482441 | 2025-05-02 00:07:18.482552 | TASK [add-build-sshkey : Add back temp key] 2025-05-02 00:07:18.863058 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/251f02d7506547999eddef8449c59e93/work/251f02d7506547999eddef8449c59e93_id_rsa (zuul-build-sshkey) 2025-05-02 00:07:18.863257 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013371 2025-05-02 00:07:18.871094 | 2025-05-02 00:07:18.871201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-02 00:07:19.275090 | ubuntu-noble | ok 2025-05-02 00:07:19.281737 | 2025-05-02 00:07:19.281838 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-02 00:07:19.305765 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 00:07:19.318971 | 2025-05-02 00:07:19.319212 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-02 00:07:19.881043 | ubuntu-noble | ok 2025-05-02 00:07:19.893679 | 2025-05-02 00:07:19.893776 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-02 00:07:19.923682 | ubuntu-noble | ok 2025-05-02 00:07:19.930906 | 2025-05-02 00:07:19.931001 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-02 00:07:20.239325 | ubuntu-noble -> localhost | ok 2025-05-02 00:07:20.252351 | 2025-05-02 00:07:20.252651 | TASK [validate-host : Collect information about the host] 2025-05-02 00:07:21.313857 | ubuntu-noble | ok 2025-05-02 00:07:21.329702 | 2025-05-02 00:07:21.329808 | TASK [validate-host : Sanitize hostname] 2025-05-02 00:07:21.382973 | ubuntu-noble | ok 2025-05-02 00:07:21.389066 | 2025-05-02 00:07:21.389156 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-02 00:07:21.958508 | ubuntu-noble -> localhost | changed 2025-05-02 00:07:21.965301 | 2025-05-02 00:07:21.965417 | TASK [validate-host : Collect information about zuul worker] 2025-05-02 00:07:22.381772 | ubuntu-noble | ok 2025-05-02 00:07:22.387918 | 2025-05-02 00:07:22.388029 | TASK [validate-host : Write out all zuul information for each host] 2025-05-02 00:07:22.910909 | ubuntu-noble -> localhost | changed 2025-05-02 00:07:22.922535 | 2025-05-02 00:07:22.922642 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-02 00:07:23.200372 | ubuntu-noble | ok 2025-05-02 00:07:23.210483 | 2025-05-02 00:07:23.210593 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-02 00:07:24.354722 | ubuntu-noble | changed: 2025-05-02 00:07:24.354922 | ubuntu-noble | cd+++++++++ src/ 2025-05-02 00:07:24.354959 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-02 00:07:24.354984 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-02 00:07:24.355006 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-05-02 00:07:24.355026 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005581 2025-05-02 00:07:57.677516 | 2025-05-02 00:07:57.677717 | TASK [upload-logs : Upload logs to log server] 2025-05-02 00:07:58.265660 | localhost | Output suppressed because no_log was given 2025-05-02 00:07:58.270004 | 2025-05-02 00:07:58.270133 | LOOP [upload-logs : Compress console log and json output] 2025-05-02 00:07:58.332540 | localhost | skipping: Conditional result was False 2025-05-02 00:07:58.350557 | localhost | skipping: Conditional result was False 2025-05-02 00:07:58.364118 | 2025-05-02 00:07:58.364234 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-02 00:07:58.428948 | localhost | skipping: Conditional result was False 2025-05-02 00:07:58.429261 | 2025-05-02 00:07:58.442491 | localhost | skipping: Conditional result was False 2025-05-02 00:07:58.446996 | 2025-05-02 00:07:58.447106 | LOOP [upload-logs : Upload console log and json output]