2025-04-15 09:35:14.053885 | Job console starting... 2025-04-15 09:35:14.073028 | Updating repositories 2025-04-15 09:35:14.126791 | Preparing job workspace 2025-04-15 09:35:15.836636 | Running Ansible setup... 2025-04-15 09:35:21.029117 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-15 09:35:21.797252 | 2025-04-15 09:35:21.797429 | PLAY [Base pre] 2025-04-15 09:35:21.826972 | 2025-04-15 09:35:21.827122 | TASK [Setup log path fact] 2025-04-15 09:35:21.869327 | ubuntu-noble | ok 2025-04-15 09:35:21.898745 | 2025-04-15 09:35:21.898906 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-15 09:35:21.940309 | ubuntu-noble | ok 2025-04-15 09:35:21.955038 | 2025-04-15 09:35:21.955170 | TASK [emit-job-header : Print job information] 2025-04-15 09:35:22.018015 | # Job Information 2025-04-15 09:35:22.018204 | Ansible Version: 2.15.3 2025-04-15 09:35:22.018239 | Job: python-black 2025-04-15 09:35:22.018268 | Pipeline: check 2025-04-15 09:35:22.018288 | Executor: 7d211f194f6a 2025-04-15 09:35:22.018307 | Triggered by: https://github.com/osism/testbed/pull/2665 2025-04-15 09:35:22.018326 | Event ID: ea1660c0-19dc-11f0-9d13-179abf453298 2025-04-15 09:35:22.025898 | 2025-04-15 09:35:22.026035 | LOOP [emit-job-header : Print node information] 2025-04-15 09:35:22.181615 | ubuntu-noble | ok: 2025-04-15 09:35:22.181908 | ubuntu-noble | # Node Information 2025-04-15 09:35:22.181949 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-15 09:35:22.181973 | ubuntu-noble | Hostname: ubuntu 2025-04-15 09:35:22.181995 | ubuntu-noble | Username: zuul 2025-04-15 09:35:22.182016 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-15 09:35:22.182040 | ubuntu-noble | Provider: regiocloud-a 2025-04-15 09:35:22.182060 | ubuntu-noble | Label: ubuntu-noble 2025-04-15 09:35:22.182081 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-15 09:35:22.182101 | ubuntu-noble | Interface IP: 81.163.192.179 2025-04-15 09:35:22.197847 | 2025-04-15 09:35:22.198001 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-15 09:35:22.775803 | ubuntu-noble -> localhost | changed 2025-04-15 09:35:22.784850 | 2025-04-15 09:35:22.784971 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-15 09:35:23.679217 | ubuntu-noble -> localhost | changed 2025-04-15 09:35:23.693112 | 2025-04-15 09:35:23.693221 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-15 09:35:23.910211 | ubuntu-noble -> localhost | ok 2025-04-15 09:35:23.917667 | 2025-04-15 09:35:23.917780 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-15 09:35:23.948824 | ubuntu-noble | ok 2025-04-15 09:35:23.974085 | ubuntu-noble | included: /var/lib/zuul/builds/d9b3379c0fff469899c34779b25d69c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-15 09:35:23.982874 | 2025-04-15 09:35:23.982968 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-15 09:35:24.606065 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-15 09:35:24.606292 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d9b3379c0fff469899c34779b25d69c4/work/d9b3379c0fff469899c34779b25d69c4_id_rsa 2025-04-15 09:35:24.606330 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d9b3379c0fff469899c34779b25d69c4/work/d9b3379c0fff469899c34779b25d69c4_id_rsa.pub 2025-04-15 09:35:24.606354 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-15 09:35:24.606377 | ubuntu-noble -> localhost | SHA256:9OSzvuAPNSoS5Pry8B7OaoGyK9uUoV4F8TBjKO8vydQ zuul-build-sshkey 2025-04-15 09:35:24.606397 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-15 09:35:24.606417 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-15 09:35:24.606437 | ubuntu-noble -> localhost | | .* | 2025-04-15 09:35:24.606456 | ubuntu-noble -> localhost | |... * | 2025-04-15 09:35:24.606490 | ubuntu-noble -> localhost | |.. ... . . | 2025-04-15 09:35:24.606518 | ubuntu-noble -> localhost | | .o. . + | 2025-04-15 09:35:24.606538 | ubuntu-noble -> localhost | | o..o. S * | 2025-04-15 09:35:24.606557 | ubuntu-noble -> localhost | |o.++E. o + | 2025-04-15 09:35:24.606582 | ubuntu-noble -> localhost | |o+==o . + . | 2025-04-15 09:35:24.606604 | ubuntu-noble -> localhost | |+oB*.o o + | 2025-04-15 09:35:24.606623 | ubuntu-noble -> localhost | |+=o*B ..+. | 2025-04-15 09:35:24.606643 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-15 09:35:24.606694 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.082771 2025-04-15 09:35:24.615397 | 2025-04-15 09:35:24.615519 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-15 09:35:24.645101 | ubuntu-noble | ok 2025-04-15 09:35:24.655722 | ubuntu-noble | included: /var/lib/zuul/builds/d9b3379c0fff469899c34779b25d69c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-15 09:35:24.665416 | 2025-04-15 09:35:24.665528 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-15 09:35:24.689339 | ubuntu-noble | skipping: Conditional result was False 2025-04-15 09:35:24.696448 | 2025-04-15 09:35:24.696549 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-15 09:35:25.335391 | ubuntu-noble | changed 2025-04-15 09:35:25.343162 | 2025-04-15 09:35:25.343255 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-15 09:35:25.638157 | ubuntu-noble | ok 2025-04-15 09:35:25.648029 | 2025-04-15 09:35:25.648138 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-15 09:35:26.416745 | ubuntu-noble | changed 2025-04-15 09:35:26.423428 | 2025-04-15 09:35:26.423535 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-15 09:35:27.141875 | ubuntu-noble | changed 2025-04-15 09:35:27.151631 | 2025-04-15 09:35:27.151763 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-15 09:35:27.187152 | ubuntu-noble | skipping: Conditional result was False 2025-04-15 09:35:27.197729 | 2025-04-15 09:35:27.197834 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-15 09:35:27.628169 | ubuntu-noble -> localhost | changed 2025-04-15 09:35:27.650314 | 2025-04-15 09:35:27.650426 | TASK [add-build-sshkey : Add back temp key] 2025-04-15 09:35:28.002276 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d9b3379c0fff469899c34779b25d69c4/work/d9b3379c0fff469899c34779b25d69c4_id_rsa (zuul-build-sshkey) 2025-04-15 09:35:28.002508 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.020419 2025-04-15 09:35:28.020449 | 2025-04-15 09:35:28.020594 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-15 09:35:28.429198 | ubuntu-noble | ok 2025-04-15 09:35:28.435720 | 2025-04-15 09:35:28.435813 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-15 09:35:28.459466 | ubuntu-noble | skipping: Conditional result was False 2025-04-15 09:35:28.472358 | 2025-04-15 09:35:28.472503 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-15 09:35:28.909962 | ubuntu-noble | ok 2025-04-15 09:35:28.945894 | 2025-04-15 09:35:28.945997 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-15 09:35:28.988289 | ubuntu-noble | ok 2025-04-15 09:35:28.995830 | 2025-04-15 09:35:28.995923 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-15 09:35:29.323864 | ubuntu-noble -> localhost | ok 2025-04-15 09:35:29.331170 | 2025-04-15 09:35:29.331270 | TASK [validate-host : Collect information about the host] 2025-04-15 09:35:30.433309 | ubuntu-noble | ok 2025-04-15 09:35:30.450675 | 2025-04-15 09:35:30.450799 | TASK [validate-host : Sanitize hostname] 2025-04-15 09:35:30.526362 | ubuntu-noble | ok 2025-04-15 09:35:30.535095 | 2025-04-15 09:35:30.535231 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-15 09:35:31.119456 | ubuntu-noble -> localhost | changed 2025-04-15 09:35:31.133622 | 2025-04-15 09:35:31.133798 | TASK [validate-host : Collect information about zuul worker] 2025-04-15 09:35:31.615620 | ubuntu-noble | ok 2025-04-15 09:35:31.624714 | 2025-04-15 09:35:31.624890 | TASK [validate-host : Write out all zuul information for each host] 2025-04-15 09:35:32.294188 | ubuntu-noble -> localhost | changed 2025-04-15 09:35:32.307792 | 2025-04-15 09:35:32.307921 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-15 09:35:32.628168 | ubuntu-noble | ok 2025-04-15 09:35:32.635733 | 2025-04-15 09:35:32.635865 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-15 09:35:34.229731 | ubuntu-noble | changed: 2025-04-15 09:35:34.229937 | ubuntu-noble | cd+++++++++ src/ 2025-04-15 09:35:34.229974 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-15 09:35:34.229998 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-15 09:35:34.230019 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-15 09:35:34.230039 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.012710 2025-04-15 09:36:06.218353 | 2025-04-15 09:36:06.218505 | TASK [upload-logs : Upload logs to log server] 2025-04-15 09:36:06.767304 | localhost | Output suppressed because no_log was given 2025-04-15 09:36:06.770807 | 2025-04-15 09:36:06.770917 | LOOP [upload-logs : Compress console log and json output] 2025-04-15 09:36:06.842458 | localhost | skipping: Conditional result was False 2025-04-15 09:36:06.862895 | localhost | skipping: Conditional result was False 2025-04-15 09:36:06.873640 | 2025-04-15 09:36:06.873764 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-15 09:36:06.945073 | localhost | skipping: Conditional result was False 2025-04-15 09:36:06.945409 | 2025-04-15 09:36:06.959180 | localhost | skipping: Conditional result was False 2025-04-15 09:36:06.970036 | 2025-04-15 09:36:06.970220 | LOOP [upload-logs : Upload console log and json output]