2025-03-06 14:50:31.447166 | Job console starting... 2025-03-06 14:50:31.456831 | Updating repositories 2025-03-06 14:50:31.504230 | Preparing job workspace 2025-03-06 14:50:33.274708 | Running Ansible setup... 2025-03-06 14:50:38.372683 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-06 14:50:39.099529 | 2025-03-06 14:50:39.099725 | PLAY [Base pre] 2025-03-06 14:50:39.134814 | 2025-03-06 14:50:39.135212 | TASK [Setup log path fact] 2025-03-06 14:50:39.177625 | ubuntu-noble | ok 2025-03-06 14:50:39.200309 | 2025-03-06 14:50:39.200487 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-06 14:50:39.272720 | ubuntu-noble | ok 2025-03-06 14:50:39.279479 | 2025-03-06 14:50:39.279615 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-06 14:50:39.316828 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:39.325348 | 2025-03-06 14:50:39.325476 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-06 14:50:39.376693 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:39.384509 | 2025-03-06 14:50:39.384653 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-06 14:50:39.408975 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:39.416866 | 2025-03-06 14:50:39.416992 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-06 14:50:39.442358 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:39.451449 | 2025-03-06 14:50:39.451608 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-06 14:50:39.477661 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:39.493054 | 2025-03-06 14:50:39.493190 | TASK [emit-job-header : Print job information] 2025-03-06 14:50:39.544463 | # Job Information 2025-03-06 14:50:39.544675 | Ansible Version: 2.15.3 2025-03-06 14:50:39.544710 | Job: yamllint 2025-03-06 14:50:39.544738 | Pipeline: check 2025-03-06 14:50:39.544758 | Executor: 7d211f194f6a 2025-03-06 14:50:39.544778 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-06 14:50:39.544796 | Event ID: 54e9c9d0-fa9a-11ef-9bad-0e22fcfd8f2f 2025-03-06 14:50:39.551168 | 2025-03-06 14:50:39.551274 | LOOP [emit-job-header : Print node information] 2025-03-06 14:50:39.692784 | ubuntu-noble | ok: 2025-03-06 14:50:39.693051 | ubuntu-noble | # Node Information 2025-03-06 14:50:39.693089 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-06 14:50:39.693114 | ubuntu-noble | Hostname: ubuntu 2025-03-06 14:50:39.693135 | ubuntu-noble | Username: zuul 2025-03-06 14:50:39.693155 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-06 14:50:39.693174 | ubuntu-noble | Provider: regiocloud-a 2025-03-06 14:50:39.693193 | ubuntu-noble | Label: ubuntu-noble 2025-03-06 14:50:39.693212 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-06 14:50:39.693231 | ubuntu-noble | Interface IP: 81.163.192.132 2025-03-06 14:50:39.710490 | 2025-03-06 14:50:39.710650 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-06 14:50:40.191202 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:40.199856 | 2025-03-06 14:50:40.199981 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-06 14:50:41.195114 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:41.207266 | 2025-03-06 14:50:41.207370 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-06 14:50:41.413112 | ubuntu-noble -> localhost | ok 2025-03-06 14:50:41.419126 | 2025-03-06 14:50:41.419208 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-06 14:50:41.438963 | ubuntu-noble | ok 2025-03-06 14:50:41.453261 | ubuntu-noble | included: /var/lib/zuul/builds/782e6a9173d44f4bbf616cbd4ef7cc7c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-06 14:50:41.459240 | 2025-03-06 14:50:41.459308 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-06 14:50:41.953437 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-06 14:50:41.953793 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/782e6a9173d44f4bbf616cbd4ef7cc7c/work/782e6a9173d44f4bbf616cbd4ef7cc7c_id_rsa 2025-03-06 14:50:41.953862 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/782e6a9173d44f4bbf616cbd4ef7cc7c/work/782e6a9173d44f4bbf616cbd4ef7cc7c_id_rsa.pub 2025-03-06 14:50:41.953907 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-06 14:50:41.953944 | ubuntu-noble -> localhost | SHA256:Hj1CIynCCVFxsqHUWAfGEEscvcSHsla/T3xS6csR9aA zuul-build-sshkey 2025-03-06 14:50:41.953982 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-06 14:50:41.954025 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-06 14:50:41.954063 | ubuntu-noble -> localhost | |+O/=+. | 2025-03-06 14:50:41.954098 | ubuntu-noble -> localhost | |oBo#.. . o | 2025-03-06 14:50:41.954131 | ubuntu-noble -> localhost | |..X = o o + o | 2025-03-06 14:50:41.954164 | ubuntu-noble -> localhost | | o o o o E . | 2025-03-06 14:50:41.954196 | ubuntu-noble -> localhost | |. o S + | 2025-03-06 14:50:41.954228 | ubuntu-noble -> localhost | | . = * . | 2025-03-06 14:50:41.954262 | ubuntu-noble -> localhost | | o = o | 2025-03-06 14:50:41.954295 | ubuntu-noble -> localhost | | . o | 2025-03-06 14:50:41.954329 | ubuntu-noble -> localhost | | | 2025-03-06 14:50:41.954361 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-06 14:50:41.954442 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.123691 2025-03-06 14:50:41.967258 | 2025-03-06 14:50:41.967366 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-06 14:50:41.997532 | ubuntu-noble | ok 2025-03-06 14:50:42.008907 | ubuntu-noble | included: /var/lib/zuul/builds/782e6a9173d44f4bbf616cbd4ef7cc7c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-06 14:50:42.018883 | 2025-03-06 14:50:42.018966 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-06 14:50:42.042304 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:42.049705 | 2025-03-06 14:50:42.049795 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-06 14:50:42.804864 | ubuntu-noble | changed 2025-03-06 14:50:42.815343 | 2025-03-06 14:50:42.815463 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-06 14:50:43.124290 | ubuntu-noble | ok 2025-03-06 14:50:43.132827 | 2025-03-06 14:50:43.132923 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-06 14:50:43.915493 | ubuntu-noble | changed 2025-03-06 14:50:43.924829 | 2025-03-06 14:50:43.924971 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-06 14:50:44.672930 | ubuntu-noble | changed 2025-03-06 14:50:44.680792 | 2025-03-06 14:50:44.680891 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-06 14:50:44.705171 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:44.712365 | 2025-03-06 14:50:44.712587 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-06 14:50:45.091360 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:45.105000 | 2025-03-06 14:50:45.105116 | TASK [add-build-sshkey : Add back temp key] 2025-03-06 14:50:45.424306 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/782e6a9173d44f4bbf616cbd4ef7cc7c/work/782e6a9173d44f4bbf616cbd4ef7cc7c_id_rsa (zuul-build-sshkey) 2025-03-06 14:50:45.424636 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014526 2025-03-06 14:50:45.432272 | 2025-03-06 14:50:45.432375 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-06 14:50:45.880335 | ubuntu-noble | ok 2025-03-06 14:50:45.915856 | 2025-03-06 14:50:45.915961 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-06 14:50:45.939915 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:45.954130 | 2025-03-06 14:50:45.954230 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-06 14:50:46.373040 | ubuntu-noble | ok 2025-03-06 14:50:46.385857 | 2025-03-06 14:50:46.385953 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-06 14:50:46.417342 | ubuntu-noble | ok 2025-03-06 14:50:46.423387 | 2025-03-06 14:50:46.423473 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-06 14:50:46.685915 | ubuntu-noble -> localhost | ok 2025-03-06 14:50:46.702538 | 2025-03-06 14:50:46.702755 | TASK [validate-host : Collect information about the host] 2025-03-06 14:50:47.927300 | ubuntu-noble | ok 2025-03-06 14:50:47.940802 | 2025-03-06 14:50:47.940895 | TASK [validate-host : Sanitize hostname] 2025-03-06 14:50:48.000635 | ubuntu-noble | ok 2025-03-06 14:50:48.006659 | 2025-03-06 14:50:48.006753 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-06 14:50:48.502706 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:48.510033 | 2025-03-06 14:50:48.510144 | TASK [validate-host : Collect information about zuul worker] 2025-03-06 14:50:48.985544 | ubuntu-noble | ok 2025-03-06 14:50:48.992233 | 2025-03-06 14:50:48.992328 | TASK [validate-host : Write out all zuul information for each host] 2025-03-06 14:50:49.538008 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:49.552101 | 2025-03-06 14:50:49.552227 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-06 14:50:49.889047 | ubuntu-noble | ok 2025-03-06 14:50:49.912339 | 2025-03-06 14:50:49.912650 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-06 14:50:51.139274 | ubuntu-noble | changed: 2025-03-06 14:50:51.139551 | ubuntu-noble | cd+++++++++ src/ 2025-03-06 14:50:51.139621 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-06 14:50:51.139649 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-06 14:50:51.139671 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-06 14:50:51.139692 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.012234 2025-03-06 14:51:26.815181 | 2025-03-06 14:51:26.815308 | TASK [upload-logs : Upload logs to log server] 2025-03-06 14:51:27.421053 | localhost | Output suppressed because no_log was given 2025-03-06 14:51:27.426137 | 2025-03-06 14:51:27.426251 | LOOP [upload-logs : Compress console log and json output] 2025-03-06 14:51:27.499484 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.525310 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.535659 | 2025-03-06 14:51:27.535769 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-06 14:51:27.599979 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.600802 | 2025-03-06 14:51:27.612635 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.631482 | 2025-03-06 14:51:27.631725 | LOOP [upload-logs : Upload console log and json output]