2025-03-12 16:31:46.521175 | Job console starting... 2025-03-12 16:31:46.562984 | Updating repositories 2025-03-12 16:31:46.594011 | Preparing job workspace 2025-03-12 16:31:48.310693 | Running Ansible setup... 2025-03-12 16:31:54.248546 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-12 16:31:55.044700 | 2025-03-12 16:31:55.045579 | PLAY [Base pre] 2025-03-12 16:31:55.110531 | 2025-03-12 16:31:55.110658 | TASK [Setup log path fact] 2025-03-12 16:31:55.135800 | ubuntu-noble | ok 2025-03-12 16:31:55.168111 | 2025-03-12 16:31:55.168248 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 16:31:55.221743 | ubuntu-noble | ok 2025-03-12 16:31:55.230239 | 2025-03-12 16:31:55.230383 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 16:31:55.276526 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:55.300174 | 2025-03-12 16:31:55.300458 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 16:31:55.358318 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:55.377384 | 2025-03-12 16:31:55.377493 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 16:31:55.413467 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:55.440499 | 2025-03-12 16:31:55.441139 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 16:31:55.513957 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:55.524052 | 2025-03-12 16:31:55.524151 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 16:31:55.548779 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:55.589394 | 2025-03-12 16:31:55.589504 | TASK [emit-job-header : Print job information] 2025-03-12 16:31:55.671953 | # Job Information 2025-03-12 16:31:55.672137 | Ansible Version: 2.15.3 2025-03-12 16:31:55.672172 | Job: ansible-lint 2025-03-12 16:31:55.672200 | Pipeline: check 2025-03-12 16:31:55.672221 | Executor: 7d211f194f6a 2025-03-12 16:31:55.672251 | Triggered by: https://github.com/osism/testbed/pull/2631 2025-03-12 16:31:55.672270 | Event ID: 736883a0-ff5f-11ef-8ab1-25b48a284636 2025-03-12 16:31:55.679108 | 2025-03-12 16:31:55.679237 | LOOP [emit-job-header : Print node information] 2025-03-12 16:31:55.929713 | ubuntu-noble | ok: 2025-03-12 16:31:55.929925 | ubuntu-noble | # Node Information 2025-03-12 16:31:55.930103 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-12 16:31:55.930133 | ubuntu-noble | Hostname: ubuntu 2025-03-12 16:31:55.930156 | ubuntu-noble | Username: zuul 2025-03-12 16:31:55.930175 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-12 16:31:55.930196 | ubuntu-noble | Provider: regiocloud-a 2025-03-12 16:31:55.930216 | ubuntu-noble | Label: ubuntu-noble 2025-03-12 16:31:55.930246 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-12 16:31:55.930265 | ubuntu-noble | Interface IP: 81.163.192.108 2025-03-12 16:31:55.965944 | 2025-03-12 16:31:55.966429 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-12 16:31:56.423565 | ubuntu-noble -> localhost | changed 2025-03-12 16:31:56.459832 | 2025-03-12 16:31:56.460291 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-12 16:31:57.466710 | ubuntu-noble -> localhost | changed 2025-03-12 16:31:57.493338 | 2025-03-12 16:31:57.493445 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-12 16:31:57.985747 | ubuntu-noble -> localhost | ok 2025-03-12 16:31:57.995909 | 2025-03-12 16:31:57.996008 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-12 16:31:58.059411 | ubuntu-noble | ok 2025-03-12 16:31:58.078484 | ubuntu-noble | included: /var/lib/zuul/builds/b983d48e430c4e35859fd939cc8cc28a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-12 16:31:58.088727 | 2025-03-12 16:31:58.088827 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-12 16:31:58.925264 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-12 16:31:58.925442 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b983d48e430c4e35859fd939cc8cc28a/work/b983d48e430c4e35859fd939cc8cc28a_id_rsa 2025-03-12 16:31:58.925477 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b983d48e430c4e35859fd939cc8cc28a/work/b983d48e430c4e35859fd939cc8cc28a_id_rsa.pub 2025-03-12 16:31:58.925502 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-12 16:31:58.925525 | ubuntu-noble -> localhost | SHA256:CV6i8hxM4VdspwWTg3DuxdUPa0vmBoAyWTHnAP2/G5Q zuul-build-sshkey 2025-03-12 16:31:58.925547 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-12 16:31:58.925572 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-12 16:31:58.925593 | ubuntu-noble -> localhost | | +**==o.. | 2025-03-12 16:31:58.925612 | ubuntu-noble -> localhost | | .+++B*oo o | 2025-03-12 16:31:58.925632 | ubuntu-noble -> localhost | | oo=o=* + | 2025-03-12 16:31:58.925652 | ubuntu-noble -> localhost | | o = =o...= . | 2025-03-12 16:31:58.925671 | ubuntu-noble -> localhost | | . + o S.E* . | 2025-03-12 16:31:58.925690 | ubuntu-noble -> localhost | | + . .. + | 2025-03-12 16:31:58.925708 | ubuntu-noble -> localhost | | o .o | 2025-03-12 16:31:58.925728 | ubuntu-noble -> localhost | | .. | 2025-03-12 16:31:58.925747 | ubuntu-noble -> localhost | | .. | 2025-03-12 16:31:58.925766 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-12 16:31:58.925811 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.181468 2025-03-12 16:31:58.933495 | 2025-03-12 16:31:58.933588 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-12 16:31:58.973623 | ubuntu-noble | ok 2025-03-12 16:31:58.985743 | ubuntu-noble | included: /var/lib/zuul/builds/b983d48e430c4e35859fd939cc8cc28a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-12 16:31:58.997945 | 2025-03-12 16:31:58.998036 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-12 16:31:59.033287 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:31:59.041435 | 2025-03-12 16:31:59.041525 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-12 16:32:00.011744 | ubuntu-noble | changed 2025-03-12 16:32:00.019255 | 2025-03-12 16:32:00.019351 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-12 16:32:00.375880 | ubuntu-noble | ok 2025-03-12 16:32:00.387197 | 2025-03-12 16:32:00.387411 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-12 16:32:01.191406 | ubuntu-noble | changed 2025-03-12 16:32:01.201836 | 2025-03-12 16:32:01.201954 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-12 16:32:02.020176 | ubuntu-noble | changed 2025-03-12 16:32:02.041684 | 2025-03-12 16:32:02.041844 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-12 16:32:02.067141 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:32:02.074126 | 2025-03-12 16:32:02.074209 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-12 16:32:02.540481 | ubuntu-noble -> localhost | changed 2025-03-12 16:32:02.554922 | 2025-03-12 16:32:02.555040 | TASK [add-build-sshkey : Add back temp key] 2025-03-12 16:32:02.935897 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b983d48e430c4e35859fd939cc8cc28a/work/b983d48e430c4e35859fd939cc8cc28a_id_rsa (zuul-build-sshkey) 2025-03-12 16:32:02.936225 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009963 2025-03-12 16:32:03.009038 | 2025-03-12 16:32:03.009146 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-12 16:32:03.594431 | ubuntu-noble | ok 2025-03-12 16:32:03.614470 | 2025-03-12 16:32:03.614577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-12 16:32:03.658564 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:32:03.675433 | 2025-03-12 16:32:03.675530 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-12 16:32:04.275448 | ubuntu-noble | ok 2025-03-12 16:32:04.289557 | 2025-03-12 16:32:04.289714 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-12 16:32:04.339215 | ubuntu-noble | ok 2025-03-12 16:32:04.351433 | 2025-03-12 16:32:04.351563 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-12 16:32:04.739784 | ubuntu-noble -> localhost | ok 2025-03-12 16:32:04.750879 | 2025-03-12 16:32:04.751060 | TASK [validate-host : Collect information about the host] 2025-03-12 16:32:06.102057 | ubuntu-noble | ok 2025-03-12 16:32:06.123705 | 2025-03-12 16:32:06.123861 | TASK [validate-host : Sanitize hostname] 2025-03-12 16:32:06.198734 | ubuntu-noble | ok 2025-03-12 16:32:06.205815 | 2025-03-12 16:32:06.205926 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-12 16:32:06.886944 | ubuntu-noble -> localhost | changed 2025-03-12 16:32:06.896628 | 2025-03-12 16:32:06.896779 | TASK [validate-host : Collect information about zuul worker] 2025-03-12 16:32:07.448563 | ubuntu-noble | ok 2025-03-12 16:32:07.461524 | 2025-03-12 16:32:07.461648 | TASK [validate-host : Write out all zuul information for each host] 2025-03-12 16:32:08.248458 | ubuntu-noble -> localhost | changed 2025-03-12 16:32:08.261392 | 2025-03-12 16:32:08.261511 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-12 16:32:08.638215 | ubuntu-noble | ok 2025-03-12 16:32:08.678549 | 2025-03-12 16:32:08.678692 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-12 16:32:10.339207 | ubuntu-noble | changed: 2025-03-12 16:32:10.339655 | ubuntu-noble | cd+++++++++ src/ 2025-03-12 16:32:10.339877 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-12 16:32:10.339932 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-12 16:32:10.339957 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-12 16:32:10.339979 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006868 2025-03-12 16:33:43.469743 | 2025-03-12 16:33:43.469901 | TASK [upload-logs : Upload logs to log server] 2025-03-12 16:33:44.034351 | localhost | Output suppressed because no_log was given 2025-03-12 16:33:44.040149 | 2025-03-12 16:33:44.040376 | LOOP [upload-logs : Compress console log and json output] 2025-03-12 16:33:44.133545 | localhost | skipping: Conditional result was False 2025-03-12 16:33:44.157913 | localhost | skipping: Conditional result was False 2025-03-12 16:33:44.164721 | 2025-03-12 16:33:44.164859 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-12 16:33:44.235528 | localhost | skipping: Conditional result was False 2025-03-12 16:33:44.235840 | 2025-03-12 16:33:44.250354 | localhost | skipping: Conditional result was False 2025-03-12 16:33:44.256055 | 2025-03-12 16:33:44.256177 | LOOP [upload-logs : Upload console log and json output]