2025-01-22 15:34:44.245444 | Job console starting... 2025-01-22 15:34:44.260365 | Updating repositories 2025-01-22 15:34:44.293072 | Preparing job workspace 2025-01-22 15:34:46.102231 | Running Ansible setup... 2025-01-22 15:34:51.437503 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-22 15:34:52.197794 | 2025-01-22 15:34:52.197958 | PLAY [Base pre] 2025-01-22 15:34:52.231482 | 2025-01-22 15:34:52.231638 | TASK [Setup log path fact] 2025-01-22 15:34:52.263597 | ubuntu-noble | ok 2025-01-22 15:34:52.285436 | 2025-01-22 15:34:52.285586 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 15:34:52.337318 | ubuntu-noble | ok 2025-01-22 15:34:52.344013 | 2025-01-22 15:34:52.344132 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 15:34:52.379583 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.387079 | 2025-01-22 15:34:52.387220 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 15:34:52.432558 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.440168 | 2025-01-22 15:34:52.440337 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 15:34:52.465337 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.472570 | 2025-01-22 15:34:52.472690 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 15:34:52.497318 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.505319 | 2025-01-22 15:34:52.505444 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 15:34:52.533762 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.563218 | 2025-01-22 15:34:52.563407 | TASK [emit-job-header : Print job information] 2025-01-22 15:34:52.616961 | # Job Information 2025-01-22 15:34:52.617157 | Ansible Version: 2.15.3 2025-01-22 15:34:52.617190 | Job: ansible-lint 2025-01-22 15:34:52.617220 | Pipeline: check 2025-01-22 15:34:52.617241 | Executor: 7d211f194f6a 2025-01-22 15:34:52.617302 | Triggered by: https://github.com/osism/testbed/pull/2592 2025-01-22 15:34:52.617323 | Event ID: 622e57e0-d8d6-11ef-8c48-e5f0b0dd580c 2025-01-22 15:34:52.624061 | 2025-01-22 15:34:52.624177 | LOOP [emit-job-header : Print node information] 2025-01-22 15:34:52.785411 | ubuntu-noble | ok: 2025-01-22 15:34:52.785781 | ubuntu-noble | # Node Information 2025-01-22 15:34:52.785840 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-22 15:34:52.785868 | ubuntu-noble | Hostname: ubuntu 2025-01-22 15:34:52.785892 | ubuntu-noble | Username: zuul 2025-01-22 15:34:52.785915 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-22 15:34:52.785937 | ubuntu-noble | Provider: regiocloud-a 2025-01-22 15:34:52.785958 | ubuntu-noble | Label: ubuntu-noble 2025-01-22 15:34:52.785980 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-22 15:34:52.786002 | ubuntu-noble | Interface IP: 81.163.192.168 2025-01-22 15:34:52.809088 | 2025-01-22 15:34:52.809359 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-22 15:34:53.362228 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:53.373717 | 2025-01-22 15:34:53.373857 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-22 15:34:54.511667 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:54.538043 | 2025-01-22 15:34:54.538237 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-22 15:34:54.838729 | ubuntu-noble -> localhost | ok 2025-01-22 15:34:54.847313 | 2025-01-22 15:34:54.847447 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-22 15:34:54.878809 | ubuntu-noble | ok 2025-01-22 15:34:54.895803 | ubuntu-noble | included: /var/lib/zuul/builds/9691f16fbad84d8b901b4f7012626eba/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-22 15:34:54.904701 | 2025-01-22 15:34:54.904835 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-22 15:34:55.908990 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-22 15:34:55.909266 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9691f16fbad84d8b901b4f7012626eba/work/9691f16fbad84d8b901b4f7012626eba_id_rsa 2025-01-22 15:34:55.909308 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9691f16fbad84d8b901b4f7012626eba/work/9691f16fbad84d8b901b4f7012626eba_id_rsa.pub 2025-01-22 15:34:55.909333 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-22 15:34:55.909357 | ubuntu-noble -> localhost | SHA256:LHSCLpUQ5BPAMqGp3YpyW04AfEaCS/4nXJfG/QBpTts zuul-build-sshkey 2025-01-22 15:34:55.909380 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-22 15:34:55.909406 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-22 15:34:55.909427 | ubuntu-noble -> localhost | |===o . | 2025-01-22 15:34:55.909448 | ubuntu-noble -> localhost | |*=oo o = | 2025-01-22 15:34:55.909468 | ubuntu-noble -> localhost | |B+oo+ B B | 2025-01-22 15:34:55.909489 | ubuntu-noble -> localhost | |o+o= o @ E | 2025-01-22 15:34:55.909508 | ubuntu-noble -> localhost | |. * + + S o | 2025-01-22 15:34:55.909527 | ubuntu-noble -> localhost | | . B . . . | 2025-01-22 15:34:55.909547 | ubuntu-noble -> localhost | |o o = | 2025-01-22 15:34:55.909568 | ubuntu-noble -> localhost | |.. = | 2025-01-22 15:34:55.909588 | ubuntu-noble -> localhost | | . . | 2025-01-22 15:34:55.909607 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-22 15:34:55.909657 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.483728 2025-01-22 15:34:55.919882 | 2025-01-22 15:34:55.920003 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-22 15:34:55.961884 | ubuntu-noble | ok 2025-01-22 15:34:55.973170 | ubuntu-noble | included: /var/lib/zuul/builds/9691f16fbad84d8b901b4f7012626eba/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-22 15:34:55.983069 | 2025-01-22 15:34:55.983179 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-22 15:34:56.018952 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:56.035015 | 2025-01-22 15:34:56.035203 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-22 15:34:56.757590 | ubuntu-noble | changed 2025-01-22 15:34:56.768295 | 2025-01-22 15:34:56.768449 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-22 15:34:57.079424 | ubuntu-noble | ok 2025-01-22 15:34:57.088800 | 2025-01-22 15:34:57.088945 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-22 15:34:57.821376 | ubuntu-noble | changed 2025-01-22 15:34:57.830733 | 2025-01-22 15:34:57.830870 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-22 15:34:58.544357 | ubuntu-noble | changed 2025-01-22 15:34:58.555980 | 2025-01-22 15:34:58.556115 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-22 15:34:58.581412 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:58.590999 | 2025-01-22 15:34:58.591143 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-22 15:34:59.055007 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:59.075044 | 2025-01-22 15:34:59.075187 | TASK [add-build-sshkey : Add back temp key] 2025-01-22 15:34:59.498637 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9691f16fbad84d8b901b4f7012626eba/work/9691f16fbad84d8b901b4f7012626eba_id_rsa (zuul-build-sshkey) 2025-01-22 15:34:59.498934 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.018352 2025-01-22 15:34:59.546117 | 2025-01-22 15:34:59.546270 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-22 15:34:59.947059 | ubuntu-noble | ok 2025-01-22 15:34:59.953792 | 2025-01-22 15:34:59.953915 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-22 15:34:59.978816 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:59.998153 | 2025-01-22 15:34:59.998299 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-22 15:35:00.413033 | ubuntu-noble | ok 2025-01-22 15:35:00.427230 | 2025-01-22 15:35:00.427382 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-22 15:35:00.469351 | ubuntu-noble | ok 2025-01-22 15:35:00.476129 | 2025-01-22 15:35:00.476242 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-22 15:35:00.766132 | ubuntu-noble -> localhost | ok 2025-01-22 15:35:00.774408 | 2025-01-22 15:35:00.774523 | TASK [validate-host : Collect information about the host] 2025-01-22 15:35:02.006166 | ubuntu-noble | ok 2025-01-22 15:35:02.018542 | 2025-01-22 15:35:02.018831 | TASK [validate-host : Sanitize hostname] 2025-01-22 15:35:02.094820 | ubuntu-noble | ok 2025-01-22 15:35:02.110898 | 2025-01-22 15:35:02.111033 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-22 15:35:02.700214 | ubuntu-noble -> localhost | changed 2025-01-22 15:35:02.709773 | 2025-01-22 15:35:02.709914 | TASK [validate-host : Collect information about zuul worker] 2025-01-22 15:35:03.205076 | ubuntu-noble | ok 2025-01-22 15:35:03.212306 | 2025-01-22 15:35:03.212452 | TASK [validate-host : Write out all zuul information for each host] 2025-01-22 15:35:03.989725 | ubuntu-noble -> localhost | changed 2025-01-22 15:35:04.012832 | 2025-01-22 15:35:04.012991 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-22 15:35:04.341421 | ubuntu-noble | ok 2025-01-22 15:35:04.348773 | 2025-01-22 15:35:04.348910 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-22 15:35:05.650178 | ubuntu-noble | changed: 2025-01-22 15:35:05.650406 | ubuntu-noble | cd+++++++++ src/ 2025-01-22 15:35:05.650441 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-22 15:35:05.650466 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-22 15:35:05.650488 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-22 15:35:05.650508 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008299 2025-01-22 15:36:31.047470 | 2025-01-22 15:36:31.047648 | TASK [upload-logs : Upload logs to log server] 2025-01-22 15:36:31.644488 | localhost | Output suppressed because no_log was given 2025-01-22 15:36:31.649603 | 2025-01-22 15:36:31.649744 | LOOP [upload-logs : Compress console log and json output] 2025-01-22 15:36:31.740497 | localhost | skipping: Conditional result was False 2025-01-22 15:36:31.765728 | localhost | skipping: Conditional result was False 2025-01-22 15:36:31.774393 | 2025-01-22 15:36:31.774540 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-22 15:36:31.843520 | localhost | skipping: Conditional result was False 2025-01-22 15:36:31.844034 | 2025-01-22 15:36:31.858200 | localhost | skipping: Conditional result was False 2025-01-22 15:36:31.868628 | 2025-01-22 15:36:31.868752 | LOOP [upload-logs : Upload console log and json output]