2025-01-27 21:13:02.842511 | Job console starting... 2025-01-27 21:13:02.857082 | Updating repositories 2025-01-27 21:13:02.894146 | Preparing job workspace 2025-01-27 21:13:04.357627 | Running Ansible setup... 2025-01-27 21:13:09.276052 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-27 21:13:10.036643 | 2025-01-27 21:13:10.036843 | PLAY [Base pre] 2025-01-27 21:13:10.069615 | 2025-01-27 21:13:10.069796 | TASK [Setup log path fact] 2025-01-27 21:13:10.101983 | ubuntu-noble | ok 2025-01-27 21:13:10.125809 | 2025-01-27 21:13:10.125990 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 21:13:10.199736 | ubuntu-noble | ok 2025-01-27 21:13:10.213980 | 2025-01-27 21:13:10.214148 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 21:13:10.259970 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:10.268123 | 2025-01-27 21:13:10.268262 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 21:13:10.340777 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:10.349946 | 2025-01-27 21:13:10.350123 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 21:13:10.377726 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:10.385496 | 2025-01-27 21:13:10.385623 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 21:13:10.422032 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:10.436597 | 2025-01-27 21:13:10.436750 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 21:13:10.472193 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:10.489268 | 2025-01-27 21:13:10.489427 | TASK [emit-job-header : Print job information] 2025-01-27 21:13:10.561465 | # Job Information 2025-01-27 21:13:10.561747 | Ansible Version: 2.15.3 2025-01-27 21:13:10.561805 | Job: flake8 2025-01-27 21:13:10.561856 | Pipeline: check 2025-01-27 21:13:10.561893 | Executor: 7d211f194f6a 2025-01-27 21:13:10.561929 | Triggered by: https://github.com/osism/openstack-project-manager/pull/213 2025-01-27 21:13:10.561963 | Event ID: 66d01010-dcf3-11ef-9b55-64405824db86 2025-01-27 21:13:10.571975 | 2025-01-27 21:13:10.572166 | LOOP [emit-job-header : Print node information] 2025-01-27 21:13:10.729951 | ubuntu-noble | ok: 2025-01-27 21:13:10.730229 | ubuntu-noble | # Node Information 2025-01-27 21:13:10.730284 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-27 21:13:10.730322 | ubuntu-noble | Hostname: ubuntu 2025-01-27 21:13:10.730356 | ubuntu-noble | Username: zuul 2025-01-27 21:13:10.730388 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-27 21:13:10.730419 | ubuntu-noble | Provider: regiocloud-a 2025-01-27 21:13:10.730475 | ubuntu-noble | Label: ubuntu-noble 2025-01-27 21:13:10.730509 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-27 21:13:10.730542 | ubuntu-noble | Interface IP: 81.163.193.91 2025-01-27 21:13:10.754459 | 2025-01-27 21:13:10.754619 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-27 21:13:11.281621 | ubuntu-noble -> localhost | changed 2025-01-27 21:13:11.292068 | 2025-01-27 21:13:11.292207 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-27 21:13:13.094099 | ubuntu-noble -> localhost | changed 2025-01-27 21:13:13.121042 | 2025-01-27 21:13:13.121192 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-27 21:13:13.586836 | ubuntu-noble -> localhost | ok 2025-01-27 21:13:13.610906 | 2025-01-27 21:13:13.611668 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-27 21:13:13.670123 | ubuntu-noble | ok 2025-01-27 21:13:13.717920 | ubuntu-noble | included: /var/lib/zuul/builds/0e893301ec454021b5e2049c2dfba123/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-27 21:13:13.730289 | 2025-01-27 21:13:13.730413 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-27 21:13:15.380030 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-27 21:13:15.380266 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0e893301ec454021b5e2049c2dfba123/work/0e893301ec454021b5e2049c2dfba123_id_rsa 2025-01-27 21:13:15.380305 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0e893301ec454021b5e2049c2dfba123/work/0e893301ec454021b5e2049c2dfba123_id_rsa.pub 2025-01-27 21:13:15.380329 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-27 21:13:15.380352 | ubuntu-noble -> localhost | SHA256:VwIlrfQtnPyiNhZ3olGhj7MJx7XTdCoQ0N2mKQ69Si0 zuul-build-sshkey 2025-01-27 21:13:15.380375 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-27 21:13:15.380440 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-27 21:13:15.380465 | ubuntu-noble -> localhost | | .oo+.. | 2025-01-27 21:13:15.380486 | ubuntu-noble -> localhost | | +o+ o | 2025-01-27 21:13:15.380505 | ubuntu-noble -> localhost | | o B.B. | 2025-01-27 21:13:15.380525 | ubuntu-noble -> localhost | | . * @oo . | 2025-01-27 21:13:15.380544 | ubuntu-noble -> localhost | | =SO.* o | 2025-01-27 21:13:15.380563 | ubuntu-noble -> localhost | | E @.O = | 2025-01-27 21:13:15.380582 | ubuntu-noble -> localhost | | . = X * | 2025-01-27 21:13:15.380601 | ubuntu-noble -> localhost | | . O | 2025-01-27 21:13:15.380621 | ubuntu-noble -> localhost | | o . | 2025-01-27 21:13:15.380640 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-27 21:13:15.380691 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.695899 2025-01-27 21:13:15.388726 | 2025-01-27 21:13:15.389701 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-27 21:13:15.441373 | ubuntu-noble | ok 2025-01-27 21:13:15.475339 | ubuntu-noble | included: /var/lib/zuul/builds/0e893301ec454021b5e2049c2dfba123/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-27 21:13:15.502983 | 2025-01-27 21:13:15.503135 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-27 21:13:15.564834 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:15.572950 | 2025-01-27 21:13:15.573090 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-27 21:13:16.611129 | ubuntu-noble | changed 2025-01-27 21:13:16.626275 | 2025-01-27 21:13:16.626390 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-27 21:13:16.933124 | ubuntu-noble | ok 2025-01-27 21:13:16.941120 | 2025-01-27 21:13:16.941221 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-27 21:13:17.719389 | ubuntu-noble | changed 2025-01-27 21:13:17.726277 | 2025-01-27 21:13:17.726380 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-27 21:13:18.434091 | ubuntu-noble | changed 2025-01-27 21:13:18.441209 | 2025-01-27 21:13:18.441307 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-27 21:13:18.466093 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:18.473662 | 2025-01-27 21:13:18.473754 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-27 21:13:18.981412 | ubuntu-noble -> localhost | changed 2025-01-27 21:13:19.046714 | 2025-01-27 21:13:19.046834 | TASK [add-build-sshkey : Add back temp key] 2025-01-27 21:13:19.992018 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0e893301ec454021b5e2049c2dfba123/work/0e893301ec454021b5e2049c2dfba123_id_rsa (zuul-build-sshkey) 2025-01-27 21:13:19.992225 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.034147 2025-01-27 21:13:20.008251 | 2025-01-27 21:13:20.008367 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-27 21:13:20.577287 | ubuntu-noble | ok 2025-01-27 21:13:20.588872 | 2025-01-27 21:13:20.589019 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-27 21:13:20.704681 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 21:13:20.738363 | 2025-01-27 21:13:20.738511 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-27 21:13:21.407557 | ubuntu-noble | ok 2025-01-27 21:13:21.422548 | 2025-01-27 21:13:21.422655 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-27 21:13:21.484483 | ubuntu-noble | ok 2025-01-27 21:13:21.490624 | 2025-01-27 21:13:21.490721 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-27 21:13:22.149462 | ubuntu-noble -> localhost | ok 2025-01-27 21:13:22.157949 | 2025-01-27 21:13:22.158042 | TASK [validate-host : Collect information about the host] 2025-01-27 21:13:23.426844 | ubuntu-noble | ok 2025-01-27 21:13:23.436885 | 2025-01-27 21:13:23.436980 | TASK [validate-host : Sanitize hostname] 2025-01-27 21:13:23.497832 | ubuntu-noble | ok 2025-01-27 21:13:23.503000 | 2025-01-27 21:13:23.503086 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-27 21:13:24.313411 | ubuntu-noble -> localhost | changed 2025-01-27 21:13:24.320497 | 2025-01-27 21:13:24.320594 | TASK [validate-host : Collect information about zuul worker] 2025-01-27 21:13:24.931106 | ubuntu-noble | ok 2025-01-27 21:13:24.937726 | 2025-01-27 21:13:24.937825 | TASK [validate-host : Write out all zuul information for each host] 2025-01-27 21:13:26.064885 | ubuntu-noble -> localhost | changed 2025-01-27 21:13:26.076214 | 2025-01-27 21:13:26.076315 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-27 21:13:26.357173 | ubuntu-noble | ok 2025-01-27 21:13:26.363632 | 2025-01-27 21:13:26.363737 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-27 21:13:27.383779 | ubuntu-noble | changed: 2025-01-27 21:13:27.383918 | ubuntu-noble | cd+++++++++ src/ 2025-01-27 21:13:27.383944 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-27 21:13:27.383963 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-27 21:13:27.383980 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-01-27 21:13:27.383996 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.020624 2025-01-27 21:14:07.082300 | 2025-01-27 21:14:07.082384 | TASK [upload-logs : Upload logs to log server] 2025-01-27 21:14:07.751654 | localhost | Output suppressed because no_log was given 2025-01-27 21:14:07.754535 | 2025-01-27 21:14:07.754615 | LOOP [upload-logs : Compress console log and json output] 2025-01-27 21:14:07.819730 | localhost | skipping: Conditional result was False 2025-01-27 21:14:07.875035 | localhost | skipping: Conditional result was False 2025-01-27 21:14:07.885491 | 2025-01-27 21:14:07.885604 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-27 21:14:08.016670 | localhost | skipping: Conditional result was False 2025-01-27 21:14:08.016973 | 2025-01-27 21:14:08.017923 | localhost | skipping: Conditional result was False 2025-01-27 21:14:08.026263 | 2025-01-27 21:14:08.026359 | LOOP [upload-logs : Upload console log and json output]