2025-01-15 19:21:49.250104 | Job console starting... 2025-01-15 19:21:49.271361 | Updating repositories 2025-01-15 19:21:49.307724 | Preparing job workspace 2025-01-15 19:21:51.941744 | Running Ansible setup... 2025-01-15 19:21:58.212720 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-15 19:21:58.837824 | 2025-01-15 19:21:58.837946 | PLAY [Base pre] 2025-01-15 19:21:58.860593 | 2025-01-15 19:21:58.860708 | TASK [Setup log path fact] 2025-01-15 19:21:58.889254 | ubuntu-noble | ok 2025-01-15 19:21:58.918173 | 2025-01-15 19:21:58.918292 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:21:58.956595 | ubuntu-noble | ok 2025-01-15 19:21:58.961791 | 2025-01-15 19:21:58.961870 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:21:59.020371 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:21:59.028815 | 2025-01-15 19:21:59.028909 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:21:59.076813 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:21:59.082750 | 2025-01-15 19:21:59.082838 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:21:59.121339 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:21:59.136360 | 2025-01-15 19:21:59.136456 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:21:59.172362 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:21:59.178440 | 2025-01-15 19:21:59.178530 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:21:59.242733 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:21:59.274824 | 2025-01-15 19:21:59.274926 | TASK [emit-job-header : Print job information] 2025-01-15 19:21:59.324741 | # Job Information 2025-01-15 19:21:59.324881 | Ansible Version: 2.15.3 2025-01-15 19:21:59.324909 | Job: ansible-lint 2025-01-15 19:21:59.324931 | Pipeline: check 2025-01-15 19:21:59.324949 | Executor: 7d211f194f6a 2025-01-15 19:21:59.324964 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/695 2025-01-15 19:21:59.324979 | Event ID: f2fa0280-d375-11ef-8c68-9d0ebf6485c1 2025-01-15 19:21:59.330577 | 2025-01-15 19:21:59.330673 | LOOP [emit-job-header : Print node information] 2025-01-15 19:21:59.512358 | ubuntu-noble | ok: 2025-01-15 19:21:59.512490 | ubuntu-noble | # Node Information 2025-01-15 19:21:59.512516 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-15 19:21:59.512535 | ubuntu-noble | Hostname: ubuntu 2025-01-15 19:21:59.512562 | ubuntu-noble | Username: zuul 2025-01-15 19:21:59.512580 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-15 19:21:59.512596 | ubuntu-noble | Provider: regiocloud-a 2025-01-15 19:21:59.512612 | ubuntu-noble | Label: ubuntu-noble 2025-01-15 19:21:59.512629 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-15 19:21:59.512654 | ubuntu-noble | Interface IP: 81.163.192.187 2025-01-15 19:21:59.523046 | 2025-01-15 19:21:59.523134 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-15 19:22:00.402320 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:00.409868 | 2025-01-15 19:22:00.409983 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-15 19:22:02.619087 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:02.635670 | 2025-01-15 19:22:02.635768 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-15 19:22:03.195673 | ubuntu-noble -> localhost | ok 2025-01-15 19:22:03.202518 | 2025-01-15 19:22:03.202606 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-15 19:22:03.265232 | ubuntu-noble | ok 2025-01-15 19:22:03.288659 | ubuntu-noble | included: /var/lib/zuul/builds/dc6f4c3a347b40369bffa1673f8ae389/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-15 19:22:03.306602 | 2025-01-15 19:22:03.306711 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-15 19:22:04.530121 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-15 19:22:04.530308 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc6f4c3a347b40369bffa1673f8ae389/work/dc6f4c3a347b40369bffa1673f8ae389_id_rsa 2025-01-15 19:22:04.530345 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc6f4c3a347b40369bffa1673f8ae389/work/dc6f4c3a347b40369bffa1673f8ae389_id_rsa.pub 2025-01-15 19:22:04.530370 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-15 19:22:04.530393 | ubuntu-noble -> localhost | SHA256:MROPTd+F+qGKx2dmaJaFC2LxxeQJHgQ9U1ZrZX7ATxM zuul-build-sshkey 2025-01-15 19:22:04.530415 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-15 19:22:04.530441 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-15 19:22:04.530463 | ubuntu-noble -> localhost | | .+o.+...+Eo| 2025-01-15 19:22:04.530483 | ubuntu-noble -> localhost | | *B.. *o+.| 2025-01-15 19:22:04.530503 | ubuntu-noble -> localhost | | .=Oo.+.ooo| 2025-01-15 19:22:04.530522 | ubuntu-noble -> localhost | | . .+=.. ...| 2025-01-15 19:22:04.530541 | ubuntu-noble -> localhost | | oS. . o . | 2025-01-15 19:22:04.530560 | ubuntu-noble -> localhost | | o o . o . | 2025-01-15 19:22:04.530579 | ubuntu-noble -> localhost | | . . + * | 2025-01-15 19:22:04.530599 | ubuntu-noble -> localhost | | . X = | 2025-01-15 19:22:04.530619 | ubuntu-noble -> localhost | | + = | 2025-01-15 19:22:04.530638 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-15 19:22:04.530698 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.265756 2025-01-15 19:22:04.538477 | 2025-01-15 19:22:04.538580 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-15 19:22:04.584385 | ubuntu-noble | ok 2025-01-15 19:22:04.606701 | ubuntu-noble | included: /var/lib/zuul/builds/dc6f4c3a347b40369bffa1673f8ae389/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-15 19:22:04.624243 | 2025-01-15 19:22:04.624348 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-15 19:22:04.663608 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:04.673769 | 2025-01-15 19:22:04.673937 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-15 19:22:05.503749 | ubuntu-noble | changed 2025-01-15 19:22:05.510629 | 2025-01-15 19:22:05.510756 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-15 19:22:05.848451 | ubuntu-noble | ok 2025-01-15 19:22:05.856602 | 2025-01-15 19:22:05.856698 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-15 19:22:06.577248 | ubuntu-noble | changed 2025-01-15 19:22:06.587042 | 2025-01-15 19:22:06.587131 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-15 19:22:07.364312 | ubuntu-noble | changed 2025-01-15 19:22:07.370702 | 2025-01-15 19:22:07.370788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-15 19:22:07.414287 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:07.421064 | 2025-01-15 19:22:07.421149 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-15 19:22:07.869102 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:07.887021 | 2025-01-15 19:22:07.887155 | TASK [add-build-sshkey : Add back temp key] 2025-01-15 19:22:08.173236 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/dc6f4c3a347b40369bffa1673f8ae389/work/dc6f4c3a347b40369bffa1673f8ae389_id_rsa (zuul-build-sshkey) 2025-01-15 19:22:08.173410 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.020090 2025-01-15 19:22:08.180274 | 2025-01-15 19:22:08.180474 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-15 19:22:08.541178 | ubuntu-noble | ok 2025-01-15 19:22:08.547682 | 2025-01-15 19:22:08.547774 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-15 19:22:08.571921 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:08.586261 | 2025-01-15 19:22:08.586355 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-15 19:22:08.989612 | ubuntu-noble | ok 2025-01-15 19:22:09.001653 | 2025-01-15 19:22:09.001750 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-15 19:22:09.052095 | ubuntu-noble | ok 2025-01-15 19:22:09.061093 | 2025-01-15 19:22:09.061218 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-15 19:22:09.361410 | ubuntu-noble -> localhost | ok 2025-01-15 19:22:09.370598 | 2025-01-15 19:22:09.370711 | TASK [validate-host : Collect information about the host] 2025-01-15 19:22:10.570369 | ubuntu-noble | ok 2025-01-15 19:22:10.609270 | 2025-01-15 19:22:10.609385 | TASK [validate-host : Sanitize hostname] 2025-01-15 19:22:10.691468 | ubuntu-noble | ok 2025-01-15 19:22:10.712096 | 2025-01-15 19:22:10.712204 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-15 19:22:11.733001 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:11.746386 | 2025-01-15 19:22:11.746498 | TASK [validate-host : Collect information about zuul worker] 2025-01-15 19:22:12.351448 | ubuntu-noble | ok 2025-01-15 19:22:12.357882 | 2025-01-15 19:22:12.357994 | TASK [validate-host : Write out all zuul information for each host] 2025-01-15 19:22:13.289684 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:13.299544 | 2025-01-15 19:22:13.299629 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-15 19:22:13.611683 | ubuntu-noble | ok 2025-01-15 19:22:13.617149 | 2025-01-15 19:22:13.617228 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-15 19:22:14.564534 | ubuntu-noble | changed: 2025-01-15 19:22:14.564707 | ubuntu-noble | cd+++++++++ src/ 2025-01-15 19:22:14.564740 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-15 19:22:14.564763 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-15 19:22:14.564784 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-01-15 19:22:14.564804 | ubuntu-noble | Containerfile 2025-01-15 19:22:14.564933 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007447 2025-01-15 19:23:19.342325 | 2025-01-15 19:23:19.342477 | TASK [upload-logs : Upload logs to log server] 2025-01-15 19:23:19.928024 | localhost | Output suppressed because no_log was given 2025-01-15 19:23:19.933827 | 2025-01-15 19:23:19.934016 | LOOP [upload-logs : Compress console log and json output] 2025-01-15 19:23:20.009068 | localhost | skipping: Conditional result was False 2025-01-15 19:23:20.028856 | localhost | skipping: Conditional result was False 2025-01-15 19:23:20.042838 | 2025-01-15 19:23:20.043045 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-15 19:23:20.104436 | localhost | skipping: Conditional result was False 2025-01-15 19:23:20.104742 | 2025-01-15 19:23:20.119125 | localhost | skipping: Conditional result was False 2025-01-15 19:23:20.129551 | 2025-01-15 19:23:20.129755 | LOOP [upload-logs : Upload console log and json output]