2025-02-08 15:16:55.070519 | Job console starting... 2025-02-08 15:16:55.086233 | Updating repositories 2025-02-08 15:16:55.129613 | Preparing job workspace 2025-02-08 15:16:56.870768 | Running Ansible setup... 2025-02-08 15:17:02.021595 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-08 15:17:02.749336 | 2025-02-08 15:17:02.749526 | PLAY [Base pre] 2025-02-08 15:17:02.780038 | 2025-02-08 15:17:02.780218 | TASK [Setup log path fact] 2025-02-08 15:17:02.816735 | ubuntu-noble | ok 2025-02-08 15:17:02.840896 | 2025-02-08 15:17:02.841106 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-08 15:17:02.892845 | ubuntu-noble | ok 2025-02-08 15:17:02.899878 | 2025-02-08 15:17:02.900001 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-08 15:17:02.977888 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:02.985489 | 2025-02-08 15:17:02.985626 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-08 15:17:03.075490 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:03.083374 | 2025-02-08 15:17:03.083513 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-08 15:17:03.109975 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:03.117457 | 2025-02-08 15:17:03.117584 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-08 15:17:03.141965 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:03.149479 | 2025-02-08 15:17:03.149613 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-08 15:17:03.184510 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:03.209959 | 2025-02-08 15:17:03.210126 | TASK [emit-job-header : Print job information] 2025-02-08 15:17:03.265980 | # Job Information 2025-02-08 15:17:03.266176 | Ansible Version: 2.15.3 2025-02-08 15:17:03.266209 | Job: ansible-lint 2025-02-08 15:17:03.266239 | Pipeline: check 2025-02-08 15:17:03.266260 | Executor: 7d211f194f6a 2025-02-08 15:17:03.266279 | Triggered by: https://github.com/osism/testbed/pull/2606 2025-02-08 15:17:03.266298 | Event ID: b6c43ca0-e62f-11ef-84fc-37f6df9a8e9f 2025-02-08 15:17:03.272676 | 2025-02-08 15:17:03.272794 | LOOP [emit-job-header : Print node information] 2025-02-08 15:17:03.414102 | ubuntu-noble | ok: 2025-02-08 15:17:03.414389 | ubuntu-noble | # Node Information 2025-02-08 15:17:03.414435 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-08 15:17:03.414466 | ubuntu-noble | Hostname: ubuntu 2025-02-08 15:17:03.414494 | ubuntu-noble | Username: zuul 2025-02-08 15:17:03.414521 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-08 15:17:03.414548 | ubuntu-noble | Provider: regiocloud-a 2025-02-08 15:17:03.414574 | ubuntu-noble | Label: ubuntu-noble 2025-02-08 15:17:03.414599 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-08 15:17:03.414625 | ubuntu-noble | Interface IP: 81.163.193.61 2025-02-08 15:17:03.438916 | 2025-02-08 15:17:03.439048 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-08 15:17:03.925200 | ubuntu-noble -> localhost | changed 2025-02-08 15:17:03.934020 | 2025-02-08 15:17:03.934167 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-08 15:17:05.039312 | ubuntu-noble -> localhost | changed 2025-02-08 15:17:05.053327 | 2025-02-08 15:17:05.053454 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-08 15:17:05.322876 | ubuntu-noble -> localhost | ok 2025-02-08 15:17:05.334896 | 2025-02-08 15:17:05.335028 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-08 15:17:05.386237 | ubuntu-noble | ok 2025-02-08 15:17:05.403164 | ubuntu-noble | included: /var/lib/zuul/builds/d113ca4d089d49dca87cde4594739511/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-08 15:17:05.411074 | 2025-02-08 15:17:05.411184 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-08 15:17:06.111990 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-08 15:17:06.112284 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d113ca4d089d49dca87cde4594739511/work/d113ca4d089d49dca87cde4594739511_id_rsa 2025-02-08 15:17:06.112326 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d113ca4d089d49dca87cde4594739511/work/d113ca4d089d49dca87cde4594739511_id_rsa.pub 2025-02-08 15:17:06.112352 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-08 15:17:06.112376 | ubuntu-noble -> localhost | SHA256:OZhjbjuf01jbaV9xe5tEBtz/SuSrWzFsvMIoJCpiq4U zuul-build-sshkey 2025-02-08 15:17:06.112419 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-08 15:17:06.112446 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-08 15:17:06.112468 | ubuntu-noble -> localhost | | | 2025-02-08 15:17:06.112488 | ubuntu-noble -> localhost | | . . | 2025-02-08 15:17:06.112508 | ubuntu-noble -> localhost | | o . | 2025-02-08 15:17:06.112528 | ubuntu-noble -> localhost | | o . o. .| 2025-02-08 15:17:06.112548 | ubuntu-noble -> localhost | | * S B+o| 2025-02-08 15:17:06.112566 | ubuntu-noble -> localhost | | . + + ..o +o+=| 2025-02-08 15:17:06.112586 | ubuntu-noble -> localhost | |E.o . o .+.oo.=o+| 2025-02-08 15:17:06.112607 | ubuntu-noble -> localhost | |.o.. ...ooo ++.++| 2025-02-08 15:17:06.112626 | ubuntu-noble -> localhost | |o. .oo. .o++o | 2025-02-08 15:17:06.112645 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-08 15:17:06.112694 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.137337 2025-02-08 15:17:06.120907 | 2025-02-08 15:17:06.121020 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-08 15:17:06.152694 | ubuntu-noble | ok 2025-02-08 15:17:06.163974 | ubuntu-noble | included: /var/lib/zuul/builds/d113ca4d089d49dca87cde4594739511/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-08 15:17:06.173920 | 2025-02-08 15:17:06.174018 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-08 15:17:06.198523 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:06.205726 | 2025-02-08 15:17:06.205832 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-08 15:17:06.902419 | ubuntu-noble | changed 2025-02-08 15:17:06.910271 | 2025-02-08 15:17:06.910385 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-08 15:17:07.188222 | ubuntu-noble | ok 2025-02-08 15:17:07.199283 | 2025-02-08 15:17:07.199420 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-08 15:17:07.972501 | ubuntu-noble | changed 2025-02-08 15:17:07.986433 | 2025-02-08 15:17:07.986609 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-08 15:17:08.745196 | ubuntu-noble | changed 2025-02-08 15:17:08.753980 | 2025-02-08 15:17:08.754143 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-08 15:17:08.792133 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:08.805077 | 2025-02-08 15:17:08.805288 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-08 15:17:09.278740 | ubuntu-noble -> localhost | changed 2025-02-08 15:17:09.294747 | 2025-02-08 15:17:09.294886 | TASK [add-build-sshkey : Add back temp key] 2025-02-08 15:17:09.639681 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d113ca4d089d49dca87cde4594739511/work/d113ca4d089d49dca87cde4594739511_id_rsa (zuul-build-sshkey) 2025-02-08 15:17:09.639988 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011028 2025-02-08 15:17:09.663027 | 2025-02-08 15:17:09.664134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-08 15:17:10.118804 | ubuntu-noble | ok 2025-02-08 15:17:10.132443 | 2025-02-08 15:17:10.132558 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-08 15:17:10.170830 | ubuntu-noble | skipping: Conditional result was False 2025-02-08 15:17:10.184535 | 2025-02-08 15:17:10.184657 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-08 15:17:10.624633 | ubuntu-noble | ok 2025-02-08 15:17:10.638712 | 2025-02-08 15:17:10.638859 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-08 15:17:10.683212 | ubuntu-noble | ok 2025-02-08 15:17:10.693744 | 2025-02-08 15:17:10.693878 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-08 15:17:10.994944 | ubuntu-noble -> localhost | ok 2025-02-08 15:17:11.003681 | 2025-02-08 15:17:11.003807 | TASK [validate-host : Collect information about the host] 2025-02-08 15:17:12.222445 | ubuntu-noble | ok 2025-02-08 15:17:12.237655 | 2025-02-08 15:17:12.237784 | TASK [validate-host : Sanitize hostname] 2025-02-08 15:17:12.321732 | ubuntu-noble | ok 2025-02-08 15:17:12.328027 | 2025-02-08 15:17:12.328158 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-08 15:17:12.928307 | ubuntu-noble -> localhost | changed 2025-02-08 15:17:12.938574 | 2025-02-08 15:17:12.938702 | TASK [validate-host : Collect information about zuul worker] 2025-02-08 15:17:13.414138 | ubuntu-noble | ok 2025-02-08 15:17:13.422346 | 2025-02-08 15:17:13.422479 | TASK [validate-host : Write out all zuul information for each host] 2025-02-08 15:17:13.998762 | ubuntu-noble -> localhost | changed 2025-02-08 15:17:14.016208 | 2025-02-08 15:17:14.016344 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-08 15:17:14.346525 | ubuntu-noble | ok 2025-02-08 15:17:14.353954 | 2025-02-08 15:17:14.354093 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-08 15:17:15.643352 | ubuntu-noble | changed: 2025-02-08 15:17:15.643688 | ubuntu-noble | cd+++++++++ src/ 2025-02-08 15:17:15.643760 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-08 15:17:15.643811 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-08 15:17:15.643856 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-02-08 15:17:15.643898 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007403 2025-02-08 15:18:34.637641 | 2025-02-08 15:18:34.638279 | TASK [upload-logs : Upload logs to log server] 2025-02-08 15:18:35.203629 | localhost | Output suppressed because no_log was given 2025-02-08 15:18:35.209807 | 2025-02-08 15:18:35.209969 | LOOP [upload-logs : Compress console log and json output] 2025-02-08 15:18:35.285660 | localhost | skipping: Conditional result was False 2025-02-08 15:18:35.303508 | localhost | skipping: Conditional result was False 2025-02-08 15:18:35.317860 | 2025-02-08 15:18:35.318190 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-08 15:18:35.383467 | localhost | skipping: Conditional result was False 2025-02-08 15:18:35.384027 | 2025-02-08 15:18:35.394996 | localhost | skipping: Conditional result was False 2025-02-08 15:18:35.405015 | 2025-02-08 15:18:35.405214 | LOOP [upload-logs : Upload console log and json output]