2025-01-06 11:01:06.829731 | Job console starting... 2025-01-06 11:01:06.883074 | Updating repositories 2025-01-06 11:01:06.920017 | Preparing job workspace 2025-01-06 11:01:08.840211 | Running Ansible setup... 2025-01-06 11:01:13.653328 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-06 11:01:14.301439 | 2025-01-06 11:01:14.301559 | PLAY [Base pre] 2025-01-06 11:01:14.335849 | 2025-01-06 11:01:14.335968 | TASK [Setup log path fact] 2025-01-06 11:01:14.365787 | ubuntu-noble | ok 2025-01-06 11:01:14.386317 | 2025-01-06 11:01:14.386437 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-06 11:01:14.426237 | ubuntu-noble | ok 2025-01-06 11:01:14.432563 | 2025-01-06 11:01:14.432656 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-06 11:01:14.476946 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:14.492565 | 2025-01-06 11:01:14.492736 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-06 11:01:14.538086 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:14.545205 | 2025-01-06 11:01:14.545324 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-06 11:01:14.569208 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:14.576051 | 2025-01-06 11:01:14.576249 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-06 11:01:14.599812 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:14.606743 | 2025-01-06 11:01:14.606839 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-06 11:01:14.620753 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:14.634695 | 2025-01-06 11:01:14.634793 | TASK [emit-job-header : Print job information] 2025-01-06 11:01:14.685704 | # Job Information 2025-01-06 11:01:14.685948 | Ansible Version: 2.15.3 2025-01-06 11:01:14.685988 | Job: yamllint 2025-01-06 11:01:14.686021 | Pipeline: check 2025-01-06 11:01:14.686047 | Executor: 7d211f194f6a 2025-01-06 11:01:14.686065 | Triggered by: https://github.com/osism/openstack-project-manager/pull/210 2025-01-06 11:01:14.686083 | Event ID: 82902f60-cc1d-11ef-8444-85e6ab8b7688 2025-01-06 11:01:14.692652 | 2025-01-06 11:01:14.692749 | LOOP [emit-job-header : Print node information] 2025-01-06 11:01:14.839455 | ubuntu-noble | ok: 2025-01-06 11:01:14.839609 | ubuntu-noble | # Node Information 2025-01-06 11:01:14.839641 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-06 11:01:14.839664 | ubuntu-noble | Hostname: ubuntu 2025-01-06 11:01:14.839685 | ubuntu-noble | Username: zuul 2025-01-06 11:01:14.839704 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-06 11:01:14.839724 | ubuntu-noble | Provider: regiocloud-a 2025-01-06 11:01:14.839744 | ubuntu-noble | Label: ubuntu-noble 2025-01-06 11:01:14.839763 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-06 11:01:14.839783 | ubuntu-noble | Interface IP: 81.163.193.98 2025-01-06 11:01:14.853503 | 2025-01-06 11:01:14.853607 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-06 11:01:15.287379 | ubuntu-noble -> localhost | changed 2025-01-06 11:01:15.295460 | 2025-01-06 11:01:15.295570 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-06 11:01:16.339067 | ubuntu-noble -> localhost | changed 2025-01-06 11:01:16.352408 | 2025-01-06 11:01:16.352504 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-06 11:01:16.673186 | ubuntu-noble -> localhost | ok 2025-01-06 11:01:16.680374 | 2025-01-06 11:01:16.680470 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-06 11:01:16.711134 | ubuntu-noble | ok 2025-01-06 11:01:16.726475 | ubuntu-noble | included: /var/lib/zuul/builds/43c48cd8fc804e558d059bd801aa7f66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-06 11:01:16.733881 | 2025-01-06 11:01:16.733977 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-06 11:01:17.496246 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-06 11:01:17.496704 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/43c48cd8fc804e558d059bd801aa7f66/work/43c48cd8fc804e558d059bd801aa7f66_id_rsa 2025-01-06 11:01:17.496792 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/43c48cd8fc804e558d059bd801aa7f66/work/43c48cd8fc804e558d059bd801aa7f66_id_rsa.pub 2025-01-06 11:01:17.496846 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-06 11:01:17.496893 | ubuntu-noble -> localhost | SHA256:lC582zusd2FlxGSd5JoJcDSSyljOoFyEEtSrQ6k5TdI zuul-build-sshkey 2025-01-06 11:01:17.496940 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-06 11:01:17.496993 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-06 11:01:17.497038 | ubuntu-noble -> localhost | |.oo o. oo+ o+o.| 2025-01-06 11:01:17.497081 | ubuntu-noble -> localhost | | . o o . o+ ..+..| 2025-01-06 11:01:17.497122 | ubuntu-noble -> localhost | | .+ + B + . . . | 2025-01-06 11:01:17.497162 | ubuntu-noble -> localhost | |.oE+ o B . * | 2025-01-06 11:01:17.497201 | ubuntu-noble -> localhost | |o=. o S * | 2025-01-06 11:01:17.497240 | ubuntu-noble -> localhost | |+o. o o o | 2025-01-06 11:01:17.497334 | ubuntu-noble -> localhost | | .. .... . | 2025-01-06 11:01:17.497389 | ubuntu-noble -> localhost | | +.. | 2025-01-06 11:01:17.497441 | ubuntu-noble -> localhost | | .o.o | 2025-01-06 11:01:17.497478 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-06 11:01:17.497589 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.314322 2025-01-06 11:01:17.509719 | 2025-01-06 11:01:17.509829 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-06 11:01:17.542352 | ubuntu-noble | ok 2025-01-06 11:01:17.562374 | ubuntu-noble | included: /var/lib/zuul/builds/43c48cd8fc804e558d059bd801aa7f66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-06 11:01:17.572455 | 2025-01-06 11:01:17.572540 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-06 11:01:17.596074 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:17.602884 | 2025-01-06 11:01:17.602968 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-06 11:01:18.338956 | ubuntu-noble | changed 2025-01-06 11:01:18.350091 | 2025-01-06 11:01:18.350209 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-06 11:01:18.657659 | ubuntu-noble | ok 2025-01-06 11:01:18.664765 | 2025-01-06 11:01:18.664861 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-06 11:01:19.375384 | ubuntu-noble | changed 2025-01-06 11:01:19.382596 | 2025-01-06 11:01:19.382702 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-06 11:01:20.120178 | ubuntu-noble | changed 2025-01-06 11:01:20.132093 | 2025-01-06 11:01:20.132492 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-06 11:01:20.177094 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:20.184477 | 2025-01-06 11:01:20.184575 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-06 11:01:20.580135 | ubuntu-noble -> localhost | changed 2025-01-06 11:01:20.591211 | 2025-01-06 11:01:20.591307 | TASK [add-build-sshkey : Add back temp key] 2025-01-06 11:01:21.029861 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/43c48cd8fc804e558d059bd801aa7f66/work/43c48cd8fc804e558d059bd801aa7f66_id_rsa (zuul-build-sshkey) 2025-01-06 11:01:21.030145 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015752 2025-01-06 11:01:21.037195 | 2025-01-06 11:01:21.037285 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-06 11:01:21.507211 | ubuntu-noble | ok 2025-01-06 11:01:21.512527 | 2025-01-06 11:01:21.512602 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-06 11:01:21.535775 | ubuntu-noble | skipping: Conditional result was False 2025-01-06 11:01:21.554375 | 2025-01-06 11:01:21.554468 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-06 11:01:22.020482 | ubuntu-noble | ok 2025-01-06 11:01:22.034606 | 2025-01-06 11:01:22.034703 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-06 11:01:22.068231 | ubuntu-noble | ok 2025-01-06 11:01:22.074581 | 2025-01-06 11:01:22.074669 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-06 11:01:22.351986 | ubuntu-noble -> localhost | ok 2025-01-06 11:01:22.359879 | 2025-01-06 11:01:22.359979 | TASK [validate-host : Collect information about the host] 2025-01-06 11:01:23.565889 | ubuntu-noble | ok 2025-01-06 11:01:23.582040 | 2025-01-06 11:01:23.582147 | TASK [validate-host : Sanitize hostname] 2025-01-06 11:01:23.641391 | ubuntu-noble | ok 2025-01-06 11:01:23.647344 | 2025-01-06 11:01:23.647444 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-06 11:01:24.369096 | ubuntu-noble -> localhost | changed 2025-01-06 11:01:24.375933 | 2025-01-06 11:01:24.376025 | TASK [validate-host : Collect information about zuul worker] 2025-01-06 11:01:24.904066 | ubuntu-noble | ok 2025-01-06 11:01:24.910824 | 2025-01-06 11:01:24.910917 | TASK [validate-host : Write out all zuul information for each host] 2025-01-06 11:01:25.434832 | ubuntu-noble -> localhost | changed 2025-01-06 11:01:25.451234 | 2025-01-06 11:01:25.451347 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-06 11:01:25.775769 | ubuntu-noble | ok 2025-01-06 11:01:25.783100 | 2025-01-06 11:01:25.783198 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-06 11:01:26.615859 | ubuntu-noble | changed: 2025-01-06 11:01:26.616010 | ubuntu-noble | cd+++++++++ src/ 2025-01-06 11:01:26.616041 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-06 11:01:26.616065 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-06 11:01:26.616087 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-01-06 11:01:26.616107 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.016570 2025-01-06 11:01:57.931568 | 2025-01-06 11:01:57.931685 | TASK [upload-logs : Upload logs to log server] 2025-01-06 11:01:58.520383 | localhost | Output suppressed because no_log was given 2025-01-06 11:01:58.523539 | 2025-01-06 11:01:58.523645 | LOOP [upload-logs : Compress console log and json output] 2025-01-06 11:01:58.584588 | localhost | skipping: Conditional result was False 2025-01-06 11:01:58.602263 | localhost | skipping: Conditional result was False 2025-01-06 11:01:58.619897 | 2025-01-06 11:01:58.620098 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-06 11:01:58.682188 | localhost | skipping: Conditional result was False 2025-01-06 11:01:58.682502 | 2025-01-06 11:01:58.694974 | localhost | skipping: Conditional result was False 2025-01-06 11:01:58.705064 | 2025-01-06 11:01:58.705243 | LOOP [upload-logs : Upload console log and json output]