2025-01-08 10:22:50.721129 | Job console starting... 2025-01-08 10:22:50.742283 | Updating repositories 2025-01-08 10:22:50.776598 | Preparing job workspace 2025-01-08 10:22:52.117160 | Running Ansible setup... 2025-01-08 10:22:58.303317 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 10:22:59.421748 | 2025-01-08 10:22:59.421867 | PLAY [Base pre] 2025-01-08 10:22:59.476424 | 2025-01-08 10:22:59.476542 | TASK [Setup log path fact] 2025-01-08 10:22:59.544500 | ubuntu-noble | ok 2025-01-08 10:22:59.583842 | 2025-01-08 10:22:59.583965 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 10:22:59.623673 | ubuntu-noble | ok 2025-01-08 10:22:59.628948 | 2025-01-08 10:22:59.629029 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 10:22:59.722255 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:59.728236 | 2025-01-08 10:22:59.728324 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 10:22:59.812511 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:59.818620 | 2025-01-08 10:22:59.818715 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 10:22:59.872500 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:59.880635 | 2025-01-08 10:22:59.880728 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 10:22:59.944479 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:22:59.951562 | 2025-01-08 10:22:59.951675 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 10:23:00.000150 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:23:00.011140 | 2025-01-08 10:23:00.011243 | TASK [emit-job-header : Print job information] 2025-01-08 10:23:00.052076 | # Job Information 2025-01-08 10:23:00.052208 | Ansible Version: 2.15.3 2025-01-08 10:23:00.052234 | Job: flake8 2025-01-08 10:23:00.052258 | Pipeline: check 2025-01-08 10:23:00.052275 | Executor: 7d211f194f6a 2025-01-08 10:23:00.052291 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/688 2025-01-08 10:23:00.052306 | Event ID: 6412c1e0-cdaa-11ef-974a-131408f3dc20 2025-01-08 10:23:00.057780 | 2025-01-08 10:23:00.057858 | LOOP [emit-job-header : Print node information] 2025-01-08 10:23:00.268534 | ubuntu-noble | ok: 2025-01-08 10:23:00.269175 | ubuntu-noble | # Node Information 2025-01-08 10:23:00.269564 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 10:23:00.269589 | ubuntu-noble | Hostname: ubuntu 2025-01-08 10:23:00.269632 | ubuntu-noble | Username: zuul 2025-01-08 10:23:00.269651 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 10:23:00.269668 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 10:23:00.269683 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 10:23:00.269699 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 10:23:00.269715 | ubuntu-noble | Interface IP: 81.163.192.227 2025-01-08 10:23:00.316172 | 2025-01-08 10:23:00.316284 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 10:23:01.831556 | ubuntu-noble -> localhost | changed 2025-01-08 10:23:01.838742 | 2025-01-08 10:23:01.838823 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 10:23:04.667141 | ubuntu-noble -> localhost | changed 2025-01-08 10:23:04.701836 | 2025-01-08 10:23:04.701975 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 10:23:05.165823 | ubuntu-noble -> localhost | ok 2025-01-08 10:23:05.171936 | 2025-01-08 10:23:05.172033 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 10:23:05.210960 | ubuntu-noble | ok 2025-01-08 10:23:05.227153 | ubuntu-noble | included: /var/lib/zuul/builds/de971e377c07480c98c8e02a9326189f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 10:23:05.234351 | 2025-01-08 10:23:05.234832 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 10:23:06.220692 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 10:23:06.220892 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/de971e377c07480c98c8e02a9326189f/work/de971e377c07480c98c8e02a9326189f_id_rsa 2025-01-08 10:23:06.220924 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/de971e377c07480c98c8e02a9326189f/work/de971e377c07480c98c8e02a9326189f_id_rsa.pub 2025-01-08 10:23:06.220944 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 10:23:06.220962 | ubuntu-noble -> localhost | SHA256:l9Bxsq636e6TYtBhHXPpJTdJN9/V81yVA3Ja1EILWOc zuul-build-sshkey 2025-01-08 10:23:06.220981 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 10:23:06.221001 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 10:23:06.221018 | ubuntu-noble -> localhost | | =++X+oB| 2025-01-08 10:23:06.221034 | ubuntu-noble -> localhost | | oo=%.**B| 2025-01-08 10:23:06.221050 | ubuntu-noble -> localhost | | ..o* E.oB| 2025-01-08 10:23:06.221066 | ubuntu-noble -> localhost | | oo... o| 2025-01-08 10:23:06.221081 | ubuntu-noble -> localhost | | oS.+ | 2025-01-08 10:23:06.221097 | ubuntu-noble -> localhost | | . .o | 2025-01-08 10:23:06.221112 | ubuntu-noble -> localhost | | .. .. | 2025-01-08 10:23:06.221128 | ubuntu-noble -> localhost | | o.oo | 2025-01-08 10:23:06.221144 | ubuntu-noble -> localhost | | . =*. | 2025-01-08 10:23:06.221159 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 10:23:06.221199 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.060246 2025-01-08 10:23:06.227517 | 2025-01-08 10:23:06.227627 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 10:23:06.297951 | ubuntu-noble | ok 2025-01-08 10:23:06.307804 | ubuntu-noble | included: /var/lib/zuul/builds/de971e377c07480c98c8e02a9326189f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 10:23:06.339005 | 2025-01-08 10:23:06.339106 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 10:23:06.374928 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:23:06.381120 | 2025-01-08 10:23:06.381219 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 10:23:07.403455 | ubuntu-noble | changed 2025-01-08 10:23:07.411830 | 2025-01-08 10:23:07.411926 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 10:23:07.746912 | ubuntu-noble | ok 2025-01-08 10:23:07.754138 | 2025-01-08 10:23:07.754242 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 10:23:08.478944 | ubuntu-noble | changed 2025-01-08 10:23:08.492783 | 2025-01-08 10:23:08.492898 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 10:23:09.279125 | ubuntu-noble | changed 2025-01-08 10:23:09.321698 | 2025-01-08 10:23:09.321799 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 10:23:09.372347 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:23:09.379867 | 2025-01-08 10:23:09.379975 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 10:23:09.836278 | ubuntu-noble -> localhost | changed 2025-01-08 10:23:09.856483 | 2025-01-08 10:23:09.856585 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 10:23:10.504553 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/de971e377c07480c98c8e02a9326189f/work/de971e377c07480c98c8e02a9326189f_id_rsa (zuul-build-sshkey) 2025-01-08 10:23:10.504739 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008533 2025-01-08 10:23:10.518991 | 2025-01-08 10:23:10.519089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 10:23:10.955600 | ubuntu-noble | ok 2025-01-08 10:23:10.964322 | 2025-01-08 10:23:10.964409 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 10:23:11.026698 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 10:23:11.039257 | 2025-01-08 10:23:11.039369 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 10:23:11.631950 | ubuntu-noble | ok 2025-01-08 10:23:11.665365 | 2025-01-08 10:23:11.665482 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 10:23:11.705905 | ubuntu-noble | ok 2025-01-08 10:23:11.730682 | 2025-01-08 10:23:11.730792 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 10:23:12.361751 | ubuntu-noble -> localhost | ok 2025-01-08 10:23:12.374980 | 2025-01-08 10:23:12.375141 | TASK [validate-host : Collect information about the host] 2025-01-08 10:23:13.621795 | ubuntu-noble | ok 2025-01-08 10:23:13.645759 | 2025-01-08 10:23:13.645856 | TASK [validate-host : Sanitize hostname] 2025-01-08 10:23:13.750842 | ubuntu-noble | ok 2025-01-08 10:23:13.760075 | 2025-01-08 10:23:13.760169 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 10:23:14.493289 | ubuntu-noble -> localhost | changed 2025-01-08 10:23:14.499872 | 2025-01-08 10:23:14.499954 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 10:23:14.960720 | ubuntu-noble | ok 2025-01-08 10:23:14.965723 | 2025-01-08 10:23:14.965808 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 10:23:15.662447 | ubuntu-noble -> localhost | changed 2025-01-08 10:23:15.682719 | 2025-01-08 10:23:15.682826 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 10:23:16.023554 | ubuntu-noble | ok 2025-01-08 10:23:16.036253 | 2025-01-08 10:23:16.036365 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 10:23:16.805240 | ubuntu-noble | changed: 2025-01-08 10:23:16.805399 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 10:23:16.805429 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 10:23:16.805452 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 10:23:16.805473 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-01-08 10:23:16.805493 | ubuntu-noble | Containerfile 2025-01-08 10:23:16.805648 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008679 2025-01-08 10:23:52.907595 | 2025-01-08 10:23:52.907775 | TASK [upload-logs : Upload logs to log server] 2025-01-08 10:23:53.610296 | localhost | Output suppressed because no_log was given 2025-01-08 10:23:53.613773 | 2025-01-08 10:23:53.613892 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 10:23:53.696840 | localhost | skipping: Conditional result was False 2025-01-08 10:23:53.716986 | localhost | skipping: Conditional result was False 2025-01-08 10:23:53.724371 | 2025-01-08 10:23:53.724496 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 10:23:53.833899 | localhost | skipping: Conditional result was False 2025-01-08 10:23:53.834336 | 2025-01-08 10:23:53.862218 | localhost | skipping: Conditional result was False 2025-01-08 10:23:53.869816 | 2025-01-08 10:23:53.870124 | LOOP [upload-logs : Upload console log and json output]