2025-01-15 19:30:13.327039 | Job console starting... 2025-01-15 19:30:13.343765 | Updating repositories 2025-01-15 19:30:13.384576 | Preparing job workspace 2025-01-15 19:30:16.400386 | Running Ansible setup... 2025-01-15 19:30:24.078949 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-15 19:30:24.842987 | 2025-01-15 19:30:24.843102 | PLAY [Base pre] 2025-01-15 19:30:24.876058 | 2025-01-15 19:30:24.876171 | TASK [Setup log path fact] 2025-01-15 19:30:24.938569 | ubuntu-noble | ok 2025-01-15 19:30:24.988019 | 2025-01-15 19:30:24.988141 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:30:25.082120 | ubuntu-noble | ok 2025-01-15 19:30:25.095096 | 2025-01-15 19:30:25.095194 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:30:25.141198 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:25.147694 | 2025-01-15 19:30:25.147790 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:30:25.244098 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:25.250163 | 2025-01-15 19:30:25.250256 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:30:25.314224 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:25.320089 | 2025-01-15 19:30:25.320179 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:30:25.404344 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:25.411496 | 2025-01-15 19:30:25.411582 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:30:25.475856 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:25.488947 | 2025-01-15 19:30:25.489046 | TASK [emit-job-header : Print job information] 2025-01-15 19:30:25.617697 | # Job Information 2025-01-15 19:30:25.617832 | Ansible Version: 2.15.3 2025-01-15 19:30:25.617858 | Job: ansible-lint 2025-01-15 19:30:25.617882 | Pipeline: check 2025-01-15 19:30:25.617900 | Executor: 7d211f194f6a 2025-01-15 19:30:25.617929 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/696 2025-01-15 19:30:25.617945 | Event ID: 1f119670-d377-11ef-99a5-7cfc0f208445 2025-01-15 19:30:25.633794 | 2025-01-15 19:30:25.633891 | LOOP [emit-job-header : Print node information] 2025-01-15 19:30:25.965338 | ubuntu-noble | ok: 2025-01-15 19:30:25.965494 | ubuntu-noble | # Node Information 2025-01-15 19:30:25.965525 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-15 19:30:25.965545 | ubuntu-noble | Hostname: ubuntu 2025-01-15 19:30:25.965562 | ubuntu-noble | Username: zuul 2025-01-15 19:30:25.965578 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-15 19:30:25.965594 | ubuntu-noble | Provider: regiocloud-a 2025-01-15 19:30:25.965610 | ubuntu-noble | Label: ubuntu-noble 2025-01-15 19:30:25.965626 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-15 19:30:25.965643 | ubuntu-noble | Interface IP: 81.163.192.31 2025-01-15 19:30:25.978980 | 2025-01-15 19:30:25.979073 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-15 19:30:26.938221 | ubuntu-noble -> localhost | changed 2025-01-15 19:30:26.945124 | 2025-01-15 19:30:26.945207 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-15 19:30:29.678610 | ubuntu-noble -> localhost | changed 2025-01-15 19:30:29.697270 | 2025-01-15 19:30:29.697385 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-15 19:30:30.466199 | ubuntu-noble -> localhost | ok 2025-01-15 19:30:30.472868 | 2025-01-15 19:30:30.472955 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-15 19:30:30.519029 | ubuntu-noble | ok 2025-01-15 19:30:30.554194 | ubuntu-noble | included: /var/lib/zuul/builds/6ab4614168d94503b759649197937711/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-15 19:30:30.592652 | 2025-01-15 19:30:30.592752 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-15 19:30:32.364776 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-15 19:30:32.364932 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/6ab4614168d94503b759649197937711/work/6ab4614168d94503b759649197937711_id_rsa 2025-01-15 19:30:32.364962 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/6ab4614168d94503b759649197937711/work/6ab4614168d94503b759649197937711_id_rsa.pub 2025-01-15 19:30:32.364984 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-15 19:30:32.365006 | ubuntu-noble -> localhost | SHA256:o6SS3kLkOFWmybVfb5sZLGsf0R/O4UBKkWl35mwk5Kg zuul-build-sshkey 2025-01-15 19:30:32.365025 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-15 19:30:32.365046 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-15 19:30:32.365064 | ubuntu-noble -> localhost | | .+. | 2025-01-15 19:30:32.365080 | ubuntu-noble -> localhost | | + ++o + | 2025-01-15 19:30:32.365097 | ubuntu-noble -> localhost | | . * . .o.oB | 2025-01-15 19:30:32.365113 | ubuntu-noble -> localhost | | * . .o + + | 2025-01-15 19:30:32.365129 | ubuntu-noble -> localhost | | = ...Eoo o.o | 2025-01-15 19:30:32.365145 | ubuntu-noble -> localhost | |o o. o....=. * o | 2025-01-15 19:30:32.365161 | ubuntu-noble -> localhost | | oo . . +.= = | 2025-01-15 19:30:32.365177 | ubuntu-noble -> localhost | | ..o o +. | 2025-01-15 19:30:32.365194 | ubuntu-noble -> localhost | | ... . .. | 2025-01-15 19:30:32.365210 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-15 19:30:32.365247 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.604003 2025-01-15 19:30:32.371774 | 2025-01-15 19:30:32.371850 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-15 19:30:32.421276 | ubuntu-noble | ok 2025-01-15 19:30:32.440540 | ubuntu-noble | included: /var/lib/zuul/builds/6ab4614168d94503b759649197937711/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-15 19:30:32.474344 | 2025-01-15 19:30:32.477039 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-15 19:30:32.490600 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:32.498238 | 2025-01-15 19:30:32.498377 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-15 19:30:33.267272 | ubuntu-noble | changed 2025-01-15 19:30:33.284093 | 2025-01-15 19:30:33.284188 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-15 19:30:33.576835 | ubuntu-noble | ok 2025-01-15 19:30:33.586111 | 2025-01-15 19:30:33.586235 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-15 19:30:34.317894 | ubuntu-noble | changed 2025-01-15 19:30:34.324605 | 2025-01-15 19:30:34.324691 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-15 19:30:35.043695 | ubuntu-noble | changed 2025-01-15 19:30:35.051547 | 2025-01-15 19:30:35.051636 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-15 19:30:35.065138 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:35.073851 | 2025-01-15 19:30:35.073955 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-15 19:30:35.617437 | ubuntu-noble -> localhost | changed 2025-01-15 19:30:35.638455 | 2025-01-15 19:30:35.638593 | TASK [add-build-sshkey : Add back temp key] 2025-01-15 19:30:36.207084 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/6ab4614168d94503b759649197937711/work/6ab4614168d94503b759649197937711_id_rsa (zuul-build-sshkey) 2025-01-15 19:30:36.207277 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.024373 2025-01-15 19:30:36.216089 | 2025-01-15 19:30:36.216191 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-15 19:30:36.717369 | ubuntu-noble | ok 2025-01-15 19:30:36.727679 | 2025-01-15 19:30:36.727785 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-15 19:30:36.791967 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:30:36.808788 | 2025-01-15 19:30:36.808884 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-15 19:30:37.397820 | ubuntu-noble | ok 2025-01-15 19:30:37.425494 | 2025-01-15 19:30:37.425592 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-15 19:30:37.506932 | ubuntu-noble | ok 2025-01-15 19:30:37.517039 | 2025-01-15 19:30:37.517132 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-15 19:30:37.917162 | ubuntu-noble -> localhost | ok 2025-01-15 19:30:37.923529 | 2025-01-15 19:30:37.923606 | TASK [validate-host : Collect information about the host] 2025-01-15 19:30:39.265534 | ubuntu-noble | ok 2025-01-15 19:30:39.278983 | 2025-01-15 19:30:39.279097 | TASK [validate-host : Sanitize hostname] 2025-01-15 19:30:39.359576 | ubuntu-noble | ok 2025-01-15 19:30:39.368788 | 2025-01-15 19:30:39.368896 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-15 19:30:40.129320 | ubuntu-noble -> localhost | changed 2025-01-15 19:30:40.137093 | 2025-01-15 19:30:40.137192 | TASK [validate-host : Collect information about zuul worker] 2025-01-15 19:30:40.654240 | ubuntu-noble | ok 2025-01-15 19:30:40.665173 | 2025-01-15 19:30:40.665281 | TASK [validate-host : Write out all zuul information for each host] 2025-01-15 19:30:41.583220 | ubuntu-noble -> localhost | changed 2025-01-15 19:30:41.599742 | 2025-01-15 19:30:41.599845 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-15 19:30:41.957885 | ubuntu-noble | ok 2025-01-15 19:30:41.984272 | 2025-01-15 19:30:41.984370 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-15 19:30:43.088666 | ubuntu-noble | changed: 2025-01-15 19:30:43.088851 | ubuntu-noble | cd+++++++++ src/ 2025-01-15 19:30:43.088877 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-15 19:30:43.088897 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-15 19:30:43.088915 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-01-15 19:30:43.088931 | ubuntu-noble | Containerfile 2025-01-15 19:30:43.089037 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006904 2025-01-15 19:31:48.226840 | 2025-01-15 19:31:48.227005 | TASK [upload-logs : Upload logs to log server] 2025-01-15 19:31:48.793834 | localhost | Output suppressed because no_log was given 2025-01-15 19:31:48.800031 | 2025-01-15 19:31:48.800520 | LOOP [upload-logs : Compress console log and json output] 2025-01-15 19:31:48.865051 | localhost | skipping: Conditional result was False 2025-01-15 19:31:48.883920 | localhost | skipping: Conditional result was False 2025-01-15 19:31:48.899099 | 2025-01-15 19:31:48.899289 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-15 19:31:48.974045 | localhost | skipping: Conditional result was False 2025-01-15 19:31:48.974356 | 2025-01-15 19:31:48.988606 | localhost | skipping: Conditional result was False 2025-01-15 19:31:49.001301 | 2025-01-15 19:31:49.001528 | LOOP [upload-logs : Upload console log and json output]