2025-04-01 18:49:50.319296 | Job console starting... 2025-04-01 18:49:50.357403 | Updating repositories 2025-04-01 18:49:50.398249 | Preparing job workspace 2025-04-01 18:49:52.137997 | Running Ansible setup... 2025-04-01 18:49:57.550353 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-01 18:49:58.279948 | 2025-04-01 18:49:58.280108 | PLAY [Base pre] 2025-04-01 18:49:58.309258 | 2025-04-01 18:49:58.309400 | TASK [Setup log path fact] 2025-04-01 18:49:58.330836 | ubuntu-noble | ok 2025-04-01 18:49:58.351655 | 2025-04-01 18:49:58.351795 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-01 18:49:58.392514 | ubuntu-noble | ok 2025-04-01 18:49:58.417307 | 2025-04-01 18:49:58.417441 | TASK [emit-job-header : Print job information] 2025-04-01 18:49:58.469390 | # Job Information 2025-04-01 18:49:58.469562 | Ansible Version: 2.15.3 2025-04-01 18:49:58.469595 | Job: python-black 2025-04-01 18:49:58.469625 | Pipeline: check 2025-04-01 18:49:58.469646 | Executor: 7d211f194f6a 2025-04-01 18:49:58.469665 | Triggered by: https://github.com/osism/testbed/pull/2654 2025-04-01 18:49:58.469684 | Event ID: 12459b00-0f2a-11f0-9f02-981e1ccc6116 2025-04-01 18:49:58.477087 | 2025-04-01 18:49:58.477219 | LOOP [emit-job-header : Print node information] 2025-04-01 18:49:58.628142 | ubuntu-noble | ok: 2025-04-01 18:49:58.628448 | ubuntu-noble | # Node Information 2025-04-01 18:49:58.628490 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-01 18:49:58.628514 | ubuntu-noble | Hostname: ubuntu 2025-04-01 18:49:58.628536 | ubuntu-noble | Username: zuul 2025-04-01 18:49:58.628555 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-01 18:49:58.628578 | ubuntu-noble | Provider: regiocloud-a 2025-04-01 18:49:58.628597 | ubuntu-noble | Label: ubuntu-noble 2025-04-01 18:49:58.628618 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-01 18:49:58.628638 | ubuntu-noble | Interface IP: 81.163.193.21 2025-04-01 18:49:58.650354 | 2025-04-01 18:49:58.650490 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-01 18:49:59.123477 | ubuntu-noble -> localhost | changed 2025-04-01 18:49:59.132515 | 2025-04-01 18:49:59.132642 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-01 18:50:00.205154 | ubuntu-noble -> localhost | changed 2025-04-01 18:50:00.216789 | 2025-04-01 18:50:00.216870 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-01 18:50:00.482995 | ubuntu-noble -> localhost | ok 2025-04-01 18:50:00.489236 | 2025-04-01 18:50:00.489325 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-01 18:50:00.517336 | ubuntu-noble | ok 2025-04-01 18:50:00.529989 | ubuntu-noble | included: /var/lib/zuul/builds/17c11d53d51a442ba550d881881d0ecd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-01 18:50:00.536065 | 2025-04-01 18:50:00.536141 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-01 18:50:01.313574 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-01 18:50:01.313717 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/17c11d53d51a442ba550d881881d0ecd/work/17c11d53d51a442ba550d881881d0ecd_id_rsa 2025-04-01 18:50:01.313746 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/17c11d53d51a442ba550d881881d0ecd/work/17c11d53d51a442ba550d881881d0ecd_id_rsa.pub 2025-04-01 18:50:01.313768 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-01 18:50:01.313789 | ubuntu-noble -> localhost | SHA256:cQj+Mq0wnobRfdPRniu6jVkCxl0o4dX7kdJIcdqa2Js zuul-build-sshkey 2025-04-01 18:50:01.313807 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-01 18:50:01.313824 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-01 18:50:01.313842 | ubuntu-noble -> localhost | | o ..... | 2025-04-01 18:50:01.313858 | ubuntu-noble -> localhost | | o + oo= | 2025-04-01 18:50:01.313874 | ubuntu-noble -> localhost | | + +.=+o. | 2025-04-01 18:50:01.313897 | ubuntu-noble -> localhost | | . o = B+=+. | 2025-04-01 18:50:01.313913 | ubuntu-noble -> localhost | | . + B S =oo. | 2025-04-01 18:50:01.313930 | ubuntu-noble -> localhost | | + = * . o.. | 2025-04-01 18:50:01.313949 | ubuntu-noble -> localhost | | . + . . E . | 2025-04-01 18:50:01.313966 | ubuntu-noble -> localhost | | . B . | 2025-04-01 18:50:01.313983 | ubuntu-noble -> localhost | | =.. | 2025-04-01 18:50:01.313999 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-01 18:50:01.314037 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.417545 2025-04-01 18:50:01.321142 | 2025-04-01 18:50:01.321230 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-01 18:50:01.339725 | ubuntu-noble | ok 2025-04-01 18:50:01.349539 | ubuntu-noble | included: /var/lib/zuul/builds/17c11d53d51a442ba550d881881d0ecd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-01 18:50:01.357166 | 2025-04-01 18:50:01.357247 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-01 18:50:01.370439 | ubuntu-noble | skipping: Conditional result was False 2025-04-01 18:50:01.377320 | 2025-04-01 18:50:01.377400 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-01 18:50:02.185017 | ubuntu-noble | changed 2025-04-01 18:50:02.196013 | 2025-04-01 18:50:02.196143 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-01 18:50:02.520325 | ubuntu-noble | ok 2025-04-01 18:50:02.530014 | 2025-04-01 18:50:02.530116 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-01 18:50:03.326021 | ubuntu-noble | changed 2025-04-01 18:50:03.341768 | 2025-04-01 18:50:03.341941 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-01 18:50:04.216154 | ubuntu-noble | changed 2025-04-01 18:50:04.221766 | 2025-04-01 18:50:04.221840 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-01 18:50:04.235605 | ubuntu-noble | skipping: Conditional result was False 2025-04-01 18:50:04.242095 | 2025-04-01 18:50:04.242210 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-01 18:50:04.631060 | ubuntu-noble -> localhost | changed 2025-04-01 18:50:04.642593 | 2025-04-01 18:50:04.642675 | TASK [add-build-sshkey : Add back temp key] 2025-04-01 18:50:04.980534 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/17c11d53d51a442ba550d881881d0ecd/work/17c11d53d51a442ba550d881881d0ecd_id_rsa (zuul-build-sshkey) 2025-04-01 18:50:04.980715 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010709 2025-04-01 18:50:04.986903 | 2025-04-01 18:50:04.987067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-01 18:50:05.389948 | ubuntu-noble | ok 2025-04-01 18:50:05.398446 | 2025-04-01 18:50:05.398556 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-01 18:50:05.432731 | ubuntu-noble | skipping: Conditional result was False 2025-04-01 18:50:05.448747 | 2025-04-01 18:50:05.448841 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-01 18:50:05.940582 | ubuntu-noble | ok 2025-04-01 18:50:05.952021 | 2025-04-01 18:50:05.952116 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-01 18:50:05.981727 | ubuntu-noble | ok 2025-04-01 18:50:05.988040 | 2025-04-01 18:50:05.988127 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-01 18:50:06.275840 | ubuntu-noble -> localhost | ok 2025-04-01 18:50:06.283308 | 2025-04-01 18:50:06.283396 | TASK [validate-host : Collect information about the host] 2025-04-01 18:50:07.491673 | ubuntu-noble | ok 2025-04-01 18:50:07.508240 | 2025-04-01 18:50:07.508340 | TASK [validate-host : Sanitize hostname] 2025-04-01 18:50:07.558369 | ubuntu-noble | ok 2025-04-01 18:50:07.564130 | 2025-04-01 18:50:07.564246 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-01 18:50:08.062817 | ubuntu-noble -> localhost | changed 2025-04-01 18:50:08.070157 | 2025-04-01 18:50:08.070285 | TASK [validate-host : Collect information about zuul worker] 2025-04-01 18:50:08.519562 | ubuntu-noble | ok 2025-04-01 18:50:08.527716 | 2025-04-01 18:50:08.528014 | TASK [validate-host : Write out all zuul information for each host] 2025-04-01 18:50:09.022218 | ubuntu-noble -> localhost | changed 2025-04-01 18:50:09.033888 | 2025-04-01 18:50:09.033982 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-01 18:50:09.395669 | ubuntu-noble | ok 2025-04-01 18:50:09.404373 | 2025-04-01 18:50:09.404512 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-01 18:50:10.591388 | ubuntu-noble | changed: 2025-04-01 18:50:10.591548 | ubuntu-noble | cd+++++++++ src/ 2025-04-01 18:50:10.591627 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-01 18:50:10.591653 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-01 18:50:10.591674 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-01 18:50:10.591693 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006606 2025-04-01 18:50:47.221492 | 2025-04-01 18:50:47.221605 | TASK [upload-logs : Upload logs to log server] 2025-04-01 18:50:47.784857 | localhost | Output suppressed because no_log was given 2025-04-01 18:50:47.788702 | 2025-04-01 18:50:47.788828 | LOOP [upload-logs : Compress console log and json output] 2025-04-01 18:50:47.867154 | localhost | skipping: Conditional result was False 2025-04-01 18:50:47.886028 | localhost | skipping: Conditional result was False 2025-04-01 18:50:47.892236 | 2025-04-01 18:50:47.892353 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-01 18:50:47.954474 | localhost | skipping: Conditional result was False 2025-04-01 18:50:47.954789 | 2025-04-01 18:50:47.968566 | localhost | skipping: Conditional result was False 2025-04-01 18:50:47.983709 | 2025-04-01 18:50:47.983833 | LOOP [upload-logs : Upload console log and json output]