2025-02-27 12:34:37.537097 | Job console starting... 2025-02-27 12:34:37.554597 | Updating repositories 2025-02-27 12:34:37.592294 | Preparing job workspace 2025-02-27 12:34:39.322291 | Running Ansible setup... 2025-02-27 12:34:44.626986 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-27 12:34:45.458794 | 2025-02-27 12:34:45.458962 | PLAY [Base pre] 2025-02-27 12:34:45.490978 | 2025-02-27 12:34:45.491131 | TASK [Setup log path fact] 2025-02-27 12:34:45.544358 | ubuntu-noble | ok 2025-02-27 12:34:45.605574 | 2025-02-27 12:34:45.605798 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 12:34:45.674715 | ubuntu-noble | ok 2025-02-27 12:34:45.681900 | 2025-02-27 12:34:45.682027 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 12:34:45.746889 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:45.754373 | 2025-02-27 12:34:45.754502 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 12:34:45.822605 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:45.830659 | 2025-02-27 12:34:45.830804 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 12:34:45.855689 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:45.863476 | 2025-02-27 12:34:45.863615 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 12:34:45.888475 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:45.896298 | 2025-02-27 12:34:45.896449 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 12:34:45.920942 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:45.936668 | 2025-02-27 12:34:45.936833 | TASK [emit-job-header : Print job information] 2025-02-27 12:34:45.988662 | # Job Information 2025-02-27 12:34:45.988892 | Ansible Version: 2.15.3 2025-02-27 12:34:45.988927 | Job: python-black 2025-02-27 12:34:45.988956 | Pipeline: check 2025-02-27 12:34:45.988977 | Executor: 7d211f194f6a 2025-02-27 12:34:45.988996 | Triggered by: https://github.com/osism/container-images-kolla/pull/554 2025-02-27 12:34:45.989014 | Event ID: 2fdec700-f507-11ef-951c-7b7b5843df20 2025-02-27 12:34:45.995839 | 2025-02-27 12:34:45.995950 | LOOP [emit-job-header : Print node information] 2025-02-27 12:34:46.160487 | ubuntu-noble | ok: 2025-02-27 12:34:46.160847 | ubuntu-noble | # Node Information 2025-02-27 12:34:46.160895 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-27 12:34:46.160920 | ubuntu-noble | Hostname: ubuntu 2025-02-27 12:34:46.160943 | ubuntu-noble | Username: zuul 2025-02-27 12:34:46.160963 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-27 12:34:46.160983 | ubuntu-noble | Provider: regiocloud-a 2025-02-27 12:34:46.161001 | ubuntu-noble | Label: ubuntu-noble 2025-02-27 12:34:46.161020 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-27 12:34:46.161040 | ubuntu-noble | Interface IP: 81.163.192.94 2025-02-27 12:34:46.184989 | 2025-02-27 12:34:46.185127 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-27 12:34:46.809811 | ubuntu-noble -> localhost | changed 2025-02-27 12:34:46.831228 | 2025-02-27 12:34:46.831353 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-27 12:34:47.994912 | ubuntu-noble -> localhost | changed 2025-02-27 12:34:48.006994 | 2025-02-27 12:34:48.007095 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-27 12:34:48.334504 | ubuntu-noble -> localhost | ok 2025-02-27 12:34:48.342015 | 2025-02-27 12:34:48.342100 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-27 12:34:48.399524 | ubuntu-noble | ok 2025-02-27 12:34:48.422696 | ubuntu-noble | included: /var/lib/zuul/builds/114ab3256cb34a7eab2ce15d92499a1f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-27 12:34:48.429207 | 2025-02-27 12:34:48.429284 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-27 12:34:49.142763 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-27 12:34:49.142961 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/114ab3256cb34a7eab2ce15d92499a1f/work/114ab3256cb34a7eab2ce15d92499a1f_id_rsa 2025-02-27 12:34:49.142993 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/114ab3256cb34a7eab2ce15d92499a1f/work/114ab3256cb34a7eab2ce15d92499a1f_id_rsa.pub 2025-02-27 12:34:49.143013 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-27 12:34:49.143032 | ubuntu-noble -> localhost | SHA256:FQPCqh3rcZFcxZxVxRBV4dIrTh/CxbuSqbmiM4hlYJ8 zuul-build-sshkey 2025-02-27 12:34:49.143051 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-27 12:34:49.143071 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-27 12:34:49.143089 | ubuntu-noble -> localhost | | .. .=+o..+B*| 2025-02-27 12:34:49.143106 | ubuntu-noble -> localhost | | ... +o + .| 2025-02-27 12:34:49.143122 | ubuntu-noble -> localhost | | o o . . = | 2025-02-27 12:34:49.143138 | ubuntu-noble -> localhost | | oo + . . o o| 2025-02-27 12:34:49.143154 | ubuntu-noble -> localhost | | .ooo..S = + | 2025-02-27 12:34:49.143170 | ubuntu-noble -> localhost | | . +E. o * o| 2025-02-27 12:34:49.143187 | ubuntu-noble -> localhost | | .+o. = o | 2025-02-27 12:34:49.143203 | ubuntu-noble -> localhost | | ... o . o . | 2025-02-27 12:34:49.143219 | ubuntu-noble -> localhost | | .+ .+. | 2025-02-27 12:34:49.143235 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-27 12:34:49.143279 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.105295 2025-02-27 12:34:49.149569 | 2025-02-27 12:34:49.149655 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-27 12:34:49.192668 | ubuntu-noble | ok 2025-02-27 12:34:49.201461 | ubuntu-noble | included: /var/lib/zuul/builds/114ab3256cb34a7eab2ce15d92499a1f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-27 12:34:49.209483 | 2025-02-27 12:34:49.209557 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-27 12:34:49.232786 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:49.238726 | 2025-02-27 12:34:49.238832 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-27 12:34:50.098032 | ubuntu-noble | changed 2025-02-27 12:34:50.119636 | 2025-02-27 12:34:50.119737 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-27 12:34:50.587536 | ubuntu-noble | ok 2025-02-27 12:34:50.600054 | 2025-02-27 12:34:50.600166 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-27 12:34:51.519009 | ubuntu-noble | changed 2025-02-27 12:34:51.525808 | 2025-02-27 12:34:51.525900 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-27 12:34:52.422255 | ubuntu-noble | changed 2025-02-27 12:34:52.431584 | 2025-02-27 12:34:52.431714 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-27 12:34:52.457429 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:52.468665 | 2025-02-27 12:34:52.468851 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-27 12:34:52.901519 | ubuntu-noble -> localhost | changed 2025-02-27 12:34:52.914694 | 2025-02-27 12:34:52.914815 | TASK [add-build-sshkey : Add back temp key] 2025-02-27 12:34:53.213011 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/114ab3256cb34a7eab2ce15d92499a1f/work/114ab3256cb34a7eab2ce15d92499a1f_id_rsa (zuul-build-sshkey) 2025-02-27 12:34:53.213213 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007126 2025-02-27 12:34:53.246290 | 2025-02-27 12:34:53.246393 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-27 12:34:53.628001 | ubuntu-noble | ok 2025-02-27 12:34:53.636841 | 2025-02-27 12:34:53.636949 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-27 12:34:53.671452 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 12:34:53.689194 | 2025-02-27 12:34:53.689309 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-27 12:34:54.157255 | ubuntu-noble | ok 2025-02-27 12:34:54.171194 | 2025-02-27 12:34:54.171301 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-27 12:34:54.201326 | ubuntu-noble | ok 2025-02-27 12:34:54.207827 | 2025-02-27 12:34:54.207915 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-27 12:34:54.445821 | ubuntu-noble -> localhost | ok 2025-02-27 12:34:54.453156 | 2025-02-27 12:34:54.453245 | TASK [validate-host : Collect information about the host] 2025-02-27 12:34:55.709322 | ubuntu-noble | ok 2025-02-27 12:34:55.721143 | 2025-02-27 12:34:55.721244 | TASK [validate-host : Sanitize hostname] 2025-02-27 12:34:55.789569 | ubuntu-noble | ok 2025-02-27 12:34:55.798890 | 2025-02-27 12:34:55.799006 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-27 12:34:56.291166 | ubuntu-noble -> localhost | changed 2025-02-27 12:34:56.297442 | 2025-02-27 12:34:56.297527 | TASK [validate-host : Collect information about zuul worker] 2025-02-27 12:34:56.764964 | ubuntu-noble | ok 2025-02-27 12:34:56.769807 | 2025-02-27 12:34:56.769888 | TASK [validate-host : Write out all zuul information for each host] 2025-02-27 12:34:57.250714 | ubuntu-noble -> localhost | changed 2025-02-27 12:34:57.266472 | 2025-02-27 12:34:57.266570 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-27 12:34:57.621985 | ubuntu-noble | ok 2025-02-27 12:34:57.628965 | 2025-02-27 12:34:57.629056 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-27 12:34:58.557834 | ubuntu-noble | changed: 2025-02-27 12:34:58.558055 | ubuntu-noble | cd+++++++++ src/ 2025-02-27 12:34:58.558100 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-27 12:34:58.558134 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-27 12:34:58.558164 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-images-kolla/ 2025-02-27 12:34:58.558193 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009891 2025-02-27 12:35:33.512550 | 2025-02-27 12:35:33.512674 | TASK [upload-logs : Upload logs to log server] 2025-02-27 12:35:34.047471 | localhost | Output suppressed because no_log was given 2025-02-27 12:35:34.050543 | 2025-02-27 12:35:34.050643 | LOOP [upload-logs : Compress console log and json output] 2025-02-27 12:35:34.117609 | localhost | skipping: Conditional result was False 2025-02-27 12:35:34.135985 | localhost | skipping: Conditional result was False 2025-02-27 12:35:34.142535 | 2025-02-27 12:35:34.142628 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-27 12:35:34.212588 | localhost | skipping: Conditional result was False 2025-02-27 12:35:34.212863 | 2025-02-27 12:35:34.227402 | localhost | skipping: Conditional result was False 2025-02-27 12:35:34.234117 | 2025-02-27 12:35:34.234245 | LOOP [upload-logs : Upload console log and json output]