2025-03-12 00:06:45.869370 | Job console starting... 2025-03-12 00:06:45.891030 | Updating repositories 2025-03-12 00:06:45.911378 | Preparing job workspace 2025-03-12 00:06:47.586644 | Running Ansible setup... 2025-03-12 00:06:53.022658 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-12 00:06:53.741842 | 2025-03-12 00:06:53.742003 | PLAY [Base pre] 2025-03-12 00:06:53.772910 | 2025-03-12 00:06:53.773055 | TASK [Setup log path fact] 2025-03-12 00:06:53.814811 | ubuntu-noble | ok 2025-03-12 00:06:53.838732 | 2025-03-12 00:06:53.838868 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 00:06:53.890537 | ubuntu-noble | ok 2025-03-12 00:06:53.897639 | 2025-03-12 00:06:53.897786 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 00:06:53.933832 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:53.941542 | 2025-03-12 00:06:53.941681 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 00:06:53.986475 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:53.994288 | 2025-03-12 00:06:53.994407 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 00:06:54.018971 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.026672 | 2025-03-12 00:06:54.026801 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 00:06:54.061308 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.070602 | 2025-03-12 00:06:54.070807 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 00:06:54.105908 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.123368 | 2025-03-12 00:06:54.123502 | TASK [emit-job-header : Print job information] 2025-03-12 00:06:54.195522 | # Job Information 2025-03-12 00:06:54.195719 | Ansible Version: 2.15.3 2025-03-12 00:06:54.195752 | Job: ansible-lint 2025-03-12 00:06:54.195781 | Pipeline: check 2025-03-12 00:06:54.195802 | Executor: 7d211f194f6a 2025-03-12 00:06:54.195821 | Triggered by: https://github.com/osism/testbed/pull/2619 2025-03-12 00:06:54.195839 | Event ID: de0cba80-fed5-11ef-862a-57d26c0a08b3 2025-03-12 00:06:54.203260 | 2025-03-12 00:06:54.203379 | LOOP [emit-job-header : Print node information] 2025-03-12 00:06:54.347798 | ubuntu-noble | ok: 2025-03-12 00:06:54.347994 | ubuntu-noble | # Node Information 2025-03-12 00:06:54.348027 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-12 00:06:54.348050 | ubuntu-noble | Hostname: ubuntu 2025-03-12 00:06:54.348072 | ubuntu-noble | Username: zuul 2025-03-12 00:06:54.348092 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-12 00:06:54.348111 | ubuntu-noble | Provider: regiocloud-a 2025-03-12 00:06:54.348130 | ubuntu-noble | Label: ubuntu-noble 2025-03-12 00:06:54.348149 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-12 00:06:54.348168 | ubuntu-noble | Interface IP: 81.163.192.27 2025-03-12 00:06:54.363056 | 2025-03-12 00:06:54.363180 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-12 00:06:54.844181 | ubuntu-noble -> localhost | changed 2025-03-12 00:06:54.862394 | 2025-03-12 00:06:54.862547 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-12 00:06:56.083419 | ubuntu-noble -> localhost | changed 2025-03-12 00:06:56.107527 | 2025-03-12 00:06:56.107697 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-12 00:06:56.483224 | ubuntu-noble -> localhost | ok 2025-03-12 00:06:56.494632 | 2025-03-12 00:06:56.494785 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-12 00:06:56.529385 | ubuntu-noble | ok 2025-03-12 00:06:56.559547 | ubuntu-noble | included: /var/lib/zuul/builds/aecbdbb17b114326b44eeb7a1a8af330/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-12 00:06:56.569759 | 2025-03-12 00:06:56.569882 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-12 00:06:57.541420 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-12 00:06:57.541712 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/aecbdbb17b114326b44eeb7a1a8af330/work/aecbdbb17b114326b44eeb7a1a8af330_id_rsa 2025-03-12 00:06:57.541761 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/aecbdbb17b114326b44eeb7a1a8af330/work/aecbdbb17b114326b44eeb7a1a8af330_id_rsa.pub 2025-03-12 00:06:57.541787 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-12 00:06:57.541810 | ubuntu-noble -> localhost | SHA256:kllNLPv6RrfJuK2DMxoSdXZqFZJKu6ss32T8YV23Jgc zuul-build-sshkey 2025-03-12 00:06:57.541833 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-12 00:06:57.541857 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-12 00:06:57.541879 | ubuntu-noble -> localhost | | .oo | 2025-03-12 00:06:57.541899 | ubuntu-noble -> localhost | | . o+.. | 2025-03-12 00:06:57.541918 | ubuntu-noble -> localhost | | ..o+o+ | 2025-03-12 00:06:57.541938 | ubuntu-noble -> localhost | | .o*.+ | 2025-03-12 00:06:57.541956 | ubuntu-noble -> localhost | | . +.S. E . | 2025-03-12 00:06:57.541975 | ubuntu-noble -> localhost | | o.o .o..o . | 2025-03-12 00:06:57.541994 | ubuntu-noble -> localhost | | . =.o+.+.o+ | 2025-03-12 00:06:57.542014 | ubuntu-noble -> localhost | | .. =.+=.+.++ | 2025-03-12 00:06:57.542052 | ubuntu-noble -> localhost | | o+.o..=++. | 2025-03-12 00:06:57.542072 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-12 00:06:57.542140 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.407979 2025-03-12 00:06:57.552549 | 2025-03-12 00:06:57.552713 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-12 00:06:57.587400 | ubuntu-noble | ok 2025-03-12 00:06:57.599800 | ubuntu-noble | included: /var/lib/zuul/builds/aecbdbb17b114326b44eeb7a1a8af330/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-12 00:06:57.610173 | 2025-03-12 00:06:57.610280 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-12 00:06:57.635131 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:57.643415 | 2025-03-12 00:06:57.643528 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-12 00:06:58.511356 | ubuntu-noble | changed 2025-03-12 00:06:58.519929 | 2025-03-12 00:06:58.520041 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-12 00:06:58.848059 | ubuntu-noble | ok 2025-03-12 00:06:58.857220 | 2025-03-12 00:06:58.857344 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-12 00:06:59.643549 | ubuntu-noble | changed 2025-03-12 00:06:59.652377 | 2025-03-12 00:06:59.652513 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-12 00:07:00.471565 | ubuntu-noble | changed 2025-03-12 00:07:00.479891 | 2025-03-12 00:07:00.480008 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-12 00:07:00.504769 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:07:00.513015 | 2025-03-12 00:07:00.513128 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-12 00:07:00.966602 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:00.982872 | 2025-03-12 00:07:00.983109 | TASK [add-build-sshkey : Add back temp key] 2025-03-12 00:07:01.523181 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/aecbdbb17b114326b44eeb7a1a8af330/work/aecbdbb17b114326b44eeb7a1a8af330_id_rsa (zuul-build-sshkey) 2025-03-12 00:07:01.523446 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009406 2025-03-12 00:07:01.572366 | 2025-03-12 00:07:01.572531 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-12 00:07:02.015050 | ubuntu-noble | ok 2025-03-12 00:07:02.022332 | 2025-03-12 00:07:02.022450 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-12 00:07:02.047470 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:07:02.061329 | 2025-03-12 00:07:02.061451 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-12 00:07:02.539590 | ubuntu-noble | ok 2025-03-12 00:07:02.554954 | 2025-03-12 00:07:02.555089 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-12 00:07:02.626546 | ubuntu-noble | ok 2025-03-12 00:07:02.636774 | 2025-03-12 00:07:02.636903 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-12 00:07:02.974382 | ubuntu-noble -> localhost | ok 2025-03-12 00:07:02.982752 | 2025-03-12 00:07:02.982876 | TASK [validate-host : Collect information about the host] 2025-03-12 00:07:04.300179 | ubuntu-noble | ok 2025-03-12 00:07:04.316705 | 2025-03-12 00:07:04.316842 | TASK [validate-host : Sanitize hostname] 2025-03-12 00:07:04.380508 | ubuntu-noble | ok 2025-03-12 00:07:04.388158 | 2025-03-12 00:07:04.388275 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-12 00:07:04.991246 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:04.999248 | 2025-03-12 00:07:04.999361 | TASK [validate-host : Collect information about zuul worker] 2025-03-12 00:07:05.590444 | ubuntu-noble | ok 2025-03-12 00:07:05.606606 | 2025-03-12 00:07:05.606805 | TASK [validate-host : Write out all zuul information for each host] 2025-03-12 00:07:06.305970 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:06.319162 | 2025-03-12 00:07:06.319296 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-12 00:07:06.686906 | ubuntu-noble | ok 2025-03-12 00:07:06.693600 | 2025-03-12 00:07:06.693706 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-12 00:07:07.731756 | ubuntu-noble | changed: 2025-03-12 00:07:07.731925 | ubuntu-noble | cd+++++++++ src/ 2025-03-12 00:07:07.731957 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-12 00:07:07.731981 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-12 00:07:07.732003 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-12 00:07:07.732022 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007141 2025-03-12 00:08:45.117261 | 2025-03-12 00:08:45.117416 | TASK [upload-logs : Upload logs to log server] 2025-03-12 00:08:45.687887 | localhost | Output suppressed because no_log was given 2025-03-12 00:08:45.691062 | 2025-03-12 00:08:45.691177 | LOOP [upload-logs : Compress console log and json output] 2025-03-12 00:08:45.753858 | localhost | skipping: Conditional result was False 2025-03-12 00:08:45.773573 | localhost | skipping: Conditional result was False 2025-03-12 00:08:45.786856 | 2025-03-12 00:08:45.787069 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-12 00:08:45.851512 | localhost | skipping: Conditional result was False 2025-03-12 00:08:45.851881 | 2025-03-12 00:08:45.867517 | localhost | skipping: Conditional result was False 2025-03-12 00:08:45.888469 | 2025-03-12 00:08:45.888719 | LOOP [upload-logs : Upload console log and json output]