2025-01-08 10:22:08.127500 | Job console starting... 2025-01-08 10:22:08.136411 | Updating repositories 2025-01-08 10:22:08.235662 | Preparing job workspace 2025-01-08 10:22:10.434857 | Running Ansible setup... 2025-01-08 10:22:16.240372 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 10:22:17.400754 | 2025-01-08 10:22:17.400883 | PLAY [Base pre] 2025-01-08 10:22:17.434100 | 2025-01-08 10:22:17.434229 | TASK [Setup log path fact] 2025-01-08 10:22:17.474766 | ubuntu-noble | ok 2025-01-08 10:22:17.518735 | 2025-01-08 10:22:17.518863 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 10:22:17.610608 | ubuntu-noble | ok 2025-01-08 10:22:17.618384 | 2025-01-08 10:22:17.618478 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 10:22:17.683064 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:17.690291 | 2025-01-08 10:22:17.690399 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 10:22:17.795579 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:17.803101 | 2025-01-08 10:22:17.803205 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 10:22:17.837074 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:17.844286 | 2025-01-08 10:22:17.844385 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 10:22:17.878147 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:17.886048 | 2025-01-08 10:22:17.886171 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 10:22:17.910137 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:17.924861 | 2025-01-08 10:22:17.924981 | TASK [emit-job-header : Print job information] 2025-01-08 10:22:17.985632 | # Job Information 2025-01-08 10:22:17.985791 | Ansible Version: 2.15.3 2025-01-08 10:22:17.985816 | Job: ansible-lint 2025-01-08 10:22:17.985839 | Pipeline: check 2025-01-08 10:22:17.985856 | Executor: 7d211f194f6a 2025-01-08 10:22:17.985871 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/688 2025-01-08 10:22:17.985887 | Event ID: 6412c1e0-cdaa-11ef-974a-131408f3dc20 2025-01-08 10:22:17.991178 | 2025-01-08 10:22:17.991268 | LOOP [emit-job-header : Print node information] 2025-01-08 10:22:18.275549 | ubuntu-noble | ok: 2025-01-08 10:22:18.275725 | ubuntu-noble | # Node Information 2025-01-08 10:22:18.275761 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 10:22:18.275786 | ubuntu-noble | Hostname: ubuntu 2025-01-08 10:22:18.275810 | ubuntu-noble | Username: zuul 2025-01-08 10:22:18.275831 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 10:22:18.275853 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 10:22:18.275875 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 10:22:18.275896 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 10:22:18.275918 | ubuntu-noble | Interface IP: 81.163.192.237 2025-01-08 10:22:18.288676 | 2025-01-08 10:22:18.288793 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 10:22:19.249819 | ubuntu-noble -> localhost | changed 2025-01-08 10:22:19.257257 | 2025-01-08 10:22:19.257361 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 10:22:20.581441 | ubuntu-noble -> localhost | changed 2025-01-08 10:22:20.596432 | 2025-01-08 10:22:20.596516 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 10:22:21.494747 | ubuntu-noble -> localhost | ok 2025-01-08 10:22:21.500928 | 2025-01-08 10:22:21.501008 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 10:22:21.572559 | ubuntu-noble | ok 2025-01-08 10:22:21.615227 | ubuntu-noble | included: /var/lib/zuul/builds/017d0e9d32234c1b8839b6a8b55b28fb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 10:22:21.632163 | 2025-01-08 10:22:21.632262 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 10:22:22.838495 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 10:22:22.838699 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/017d0e9d32234c1b8839b6a8b55b28fb/work/017d0e9d32234c1b8839b6a8b55b28fb_id_rsa 2025-01-08 10:22:22.838730 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/017d0e9d32234c1b8839b6a8b55b28fb/work/017d0e9d32234c1b8839b6a8b55b28fb_id_rsa.pub 2025-01-08 10:22:22.838751 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 10:22:22.838771 | ubuntu-noble -> localhost | SHA256:m2dyKjuITDrB54nDOmkMQ96B2ngS6/Xpu8NzShxSugU zuul-build-sshkey 2025-01-08 10:22:22.838790 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 10:22:22.838811 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 10:22:22.838829 | ubuntu-noble -> localhost | | | 2025-01-08 10:22:22.838846 | ubuntu-noble -> localhost | | | 2025-01-08 10:22:22.838863 | ubuntu-noble -> localhost | | .E . | 2025-01-08 10:22:22.838879 | ubuntu-noble -> localhost | |.o .+ | 2025-01-08 10:22:22.838896 | ubuntu-noble -> localhost | |==.o.o S | 2025-01-08 10:22:22.838913 | ubuntu-noble -> localhost | |Oo++= . o | 2025-01-08 10:22:22.838929 | ubuntu-noble -> localhost | |=X=o++. + + | 2025-01-08 10:22:22.838946 | ubuntu-noble -> localhost | |=Booo*o. * | 2025-01-08 10:22:22.838963 | ubuntu-noble -> localhost | |+o. .=O+. | 2025-01-08 10:22:22.838980 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 10:22:22.839021 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.343564 2025-01-08 10:22:22.845471 | 2025-01-08 10:22:22.845558 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 10:22:22.915559 | ubuntu-noble | ok 2025-01-08 10:22:22.945294 | ubuntu-noble | included: /var/lib/zuul/builds/017d0e9d32234c1b8839b6a8b55b28fb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 10:22:22.965399 | 2025-01-08 10:22:22.965511 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 10:22:23.036725 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:23.043029 | 2025-01-08 10:22:23.043118 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 10:22:23.792613 | ubuntu-noble | changed 2025-01-08 10:22:23.807537 | 2025-01-08 10:22:23.807681 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 10:22:24.204507 | ubuntu-noble | ok 2025-01-08 10:22:24.225401 | 2025-01-08 10:22:24.225554 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 10:22:24.751800 | ubuntu-noble | ok 2025-01-08 10:22:24.758736 | 2025-01-08 10:22:24.758839 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 10:22:25.287999 | ubuntu-noble | ok 2025-01-08 10:22:25.294960 | 2025-01-08 10:22:25.295047 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 10:22:25.343032 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:25.350435 | 2025-01-08 10:22:25.350534 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 10:22:26.334289 | ubuntu-noble -> localhost | changed 2025-01-08 10:22:26.417140 | 2025-01-08 10:22:26.417247 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 10:22:26.942932 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/017d0e9d32234c1b8839b6a8b55b28fb/work/017d0e9d32234c1b8839b6a8b55b28fb_id_rsa (zuul-build-sshkey) 2025-01-08 10:22:26.943135 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.026540 2025-01-08 10:22:26.949318 | 2025-01-08 10:22:26.949398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 10:22:27.466955 | ubuntu-noble | ok 2025-01-08 10:22:27.472694 | 2025-01-08 10:22:27.472782 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 10:22:27.503582 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:27.525842 | 2025-01-08 10:22:27.525952 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 10:22:28.021635 | ubuntu-noble | ok 2025-01-08 10:22:28.035811 | 2025-01-08 10:22:28.035913 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 10:22:28.100253 | ubuntu-noble | ok 2025-01-08 10:22:28.112376 | 2025-01-08 10:22:28.112463 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 10:22:28.359341 | ubuntu-noble -> localhost | ok 2025-01-08 10:22:28.371741 | 2025-01-08 10:22:28.371841 | TASK [validate-host : Collect information about the host] 2025-01-08 10:22:29.561002 | ubuntu-noble | ok 2025-01-08 10:22:29.576672 | 2025-01-08 10:22:29.576772 | TASK [validate-host : Sanitize hostname] 2025-01-08 10:22:29.636510 | ubuntu-noble | ok 2025-01-08 10:22:29.641508 | 2025-01-08 10:22:29.641587 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 10:22:30.193796 | ubuntu-noble -> localhost | changed 2025-01-08 10:22:30.199578 | 2025-01-08 10:22:30.199669 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 10:22:30.751675 | ubuntu-noble | ok 2025-01-08 10:22:30.759022 | 2025-01-08 10:22:30.759123 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 10:22:31.281295 | ubuntu-noble -> localhost | changed 2025-01-08 10:22:31.301177 | 2025-01-08 10:22:31.301297 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 10:22:31.755876 | ubuntu-noble | ok 2025-01-08 10:22:31.769607 | 2025-01-08 10:22:31.769777 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 10:22:32.478542 | ubuntu-noble | changed: 2025-01-08 10:22:32.478716 | ubuntu-noble | .d..t...... src/ 2025-01-08 10:22:32.478750 | ubuntu-noble | .d..t...... src/github.com/ 2025-01-08 10:22:32.478774 | ubuntu-noble | .d..t...... src/github.com/osism/ 2025-01-08 10:22:32.478795 | ubuntu-noble | .d..t...... src/github.com/osism/cfg-cookiecutter/ 2025-01-08 10:22:32.478814 | ubuntu-noble | Containerfile 2025-01-08 10:22:32.478945 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004712 2025-01-08 10:23:49.953635 | 2025-01-08 10:23:49.953833 | TASK [upload-logs : Upload logs to log server] 2025-01-08 10:23:50.566485 | localhost | Output suppressed because no_log was given 2025-01-08 10:23:50.573980 | 2025-01-08 10:23:50.574136 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 10:23:50.641261 | localhost | skipping: Conditional result was False 2025-01-08 10:23:50.661509 | localhost | skipping: Conditional result was False 2025-01-08 10:23:50.671987 | 2025-01-08 10:23:50.672307 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 10:23:50.748475 | localhost | skipping: Conditional result was False 2025-01-08 10:23:50.749112 | 2025-01-08 10:23:50.761878 | localhost | skipping: Conditional result was False 2025-01-08 10:23:50.777211 | 2025-01-08 10:23:50.777339 | LOOP [upload-logs : Upload console log and json output]