2025-01-16 21:23:59.297864 | Job console starting... 2025-01-16 21:23:59.322251 | Updating repositories 2025-01-16 21:23:59.352909 | Preparing job workspace 2025-01-16 21:24:01.092554 | Running Ansible setup... 2025-01-16 21:24:06.662803 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-16 21:24:07.701320 | 2025-01-16 21:24:07.701525 | PLAY [Base pre] 2025-01-16 21:24:07.734404 | 2025-01-16 21:24:07.734607 | TASK [Setup log path fact] 2025-01-16 21:24:07.767466 | ubuntu-noble | ok 2025-01-16 21:24:07.792780 | 2025-01-16 21:24:07.792936 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 21:24:07.881693 | ubuntu-noble | ok 2025-01-16 21:24:07.915971 | 2025-01-16 21:24:07.916112 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 21:24:07.969748 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:07.977546 | 2025-01-16 21:24:07.977671 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 21:24:08.024282 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:08.034972 | 2025-01-16 21:24:08.035107 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 21:24:08.060711 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:08.070549 | 2025-01-16 21:24:08.070672 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 21:24:08.097556 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:08.106444 | 2025-01-16 21:24:08.106611 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 21:24:08.134322 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:08.153111 | 2025-01-16 21:24:08.153241 | TASK [emit-job-header : Print job information] 2025-01-16 21:24:08.223175 | # Job Information 2025-01-16 21:24:08.223377 | Ansible Version: 2.15.3 2025-01-16 21:24:08.223409 | Job: flake8 2025-01-16 21:24:08.223437 | Pipeline: check 2025-01-16 21:24:08.223457 | Executor: 7d211f194f6a 2025-01-16 21:24:08.223475 | Triggered by: https://github.com/osism/testbed/pull/2585 2025-01-16 21:24:08.223515 | Event ID: 2ee49820-d450-11ef-90f4-81ced156e6d1 2025-01-16 21:24:08.232310 | 2025-01-16 21:24:08.232437 | LOOP [emit-job-header : Print node information] 2025-01-16 21:24:08.410277 | ubuntu-noble | ok: 2025-01-16 21:24:08.410544 | ubuntu-noble | # Node Information 2025-01-16 21:24:08.410583 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-16 21:24:08.410607 | ubuntu-noble | Hostname: ubuntu 2025-01-16 21:24:08.410628 | ubuntu-noble | Username: zuul 2025-01-16 21:24:08.410648 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-16 21:24:08.410668 | ubuntu-noble | Provider: regiocloud-a 2025-01-16 21:24:08.410689 | ubuntu-noble | Label: ubuntu-noble 2025-01-16 21:24:08.410708 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-16 21:24:08.410728 | ubuntu-noble | Interface IP: 81.163.192.203 2025-01-16 21:24:08.439381 | 2025-01-16 21:24:08.439541 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-16 21:24:09.134357 | ubuntu-noble -> localhost | changed 2025-01-16 21:24:09.148779 | 2025-01-16 21:24:09.148910 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-16 21:24:10.608387 | ubuntu-noble -> localhost | changed 2025-01-16 21:24:10.621406 | 2025-01-16 21:24:10.621529 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-16 21:24:10.859375 | ubuntu-noble -> localhost | ok 2025-01-16 21:24:10.866589 | 2025-01-16 21:24:10.866696 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-16 21:24:10.903904 | ubuntu-noble | ok 2025-01-16 21:24:10.920367 | ubuntu-noble | included: /var/lib/zuul/builds/ad624588ce0e4eb68acfd3bdf8bcb8cb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-16 21:24:10.927754 | 2025-01-16 21:24:10.927838 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-16 21:24:11.791382 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-16 21:24:11.791577 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ad624588ce0e4eb68acfd3bdf8bcb8cb/work/ad624588ce0e4eb68acfd3bdf8bcb8cb_id_rsa 2025-01-16 21:24:11.791612 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ad624588ce0e4eb68acfd3bdf8bcb8cb/work/ad624588ce0e4eb68acfd3bdf8bcb8cb_id_rsa.pub 2025-01-16 21:24:11.791637 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-16 21:24:11.791661 | ubuntu-noble -> localhost | SHA256:gN2tbPR5GZ6dDQfIAxmry4hCLWJDa+yWlLY2imUL6rA zuul-build-sshkey 2025-01-16 21:24:11.791684 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-16 21:24:11.791709 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-16 21:24:11.791729 | ubuntu-noble -> localhost | | o= .. | 2025-01-16 21:24:11.791749 | ubuntu-noble -> localhost | | o . ...+ . | 2025-01-16 21:24:11.791768 | ubuntu-noble -> localhost | | . . o o o ... .| 2025-01-16 21:24:11.791787 | ubuntu-noble -> localhost | |o o. + + o = = | 2025-01-16 21:24:11.791806 | ubuntu-noble -> localhost | |.Xo . S o = o .| 2025-01-16 21:24:11.791824 | ubuntu-noble -> localhost | |*o+. . + . . | 2025-01-16 21:24:11.791843 | ubuntu-noble -> localhost | |oB+ . . o | 2025-01-16 21:24:11.791863 | ubuntu-noble -> localhost | |B=.o | 2025-01-16 21:24:11.791883 | ubuntu-noble -> localhost | |E.. | 2025-01-16 21:24:11.791902 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-16 21:24:11.791947 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.404147 2025-01-16 21:24:11.800001 | 2025-01-16 21:24:11.800089 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-16 21:24:11.847772 | ubuntu-noble | ok 2025-01-16 21:24:11.858687 | ubuntu-noble | included: /var/lib/zuul/builds/ad624588ce0e4eb68acfd3bdf8bcb8cb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-16 21:24:11.868012 | 2025-01-16 21:24:11.868096 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-16 21:24:11.891589 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:11.898537 | 2025-01-16 21:24:11.898620 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-16 21:24:12.582838 | ubuntu-noble | changed 2025-01-16 21:24:12.589751 | 2025-01-16 21:24:12.589837 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-16 21:24:12.888437 | ubuntu-noble | ok 2025-01-16 21:24:12.896447 | 2025-01-16 21:24:12.896569 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-16 21:24:13.612777 | ubuntu-noble | changed 2025-01-16 21:24:13.620687 | 2025-01-16 21:24:13.620787 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-16 21:24:14.334140 | ubuntu-noble | changed 2025-01-16 21:24:14.343893 | 2025-01-16 21:24:14.344027 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-16 21:24:14.369087 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:14.376433 | 2025-01-16 21:24:14.376529 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-16 21:24:14.755215 | ubuntu-noble -> localhost | changed 2025-01-16 21:24:14.768479 | 2025-01-16 21:24:14.768586 | TASK [add-build-sshkey : Add back temp key] 2025-01-16 21:24:15.261567 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/ad624588ce0e4eb68acfd3bdf8bcb8cb/work/ad624588ce0e4eb68acfd3bdf8bcb8cb_id_rsa (zuul-build-sshkey) 2025-01-16 21:24:15.261773 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.027929 2025-01-16 21:24:15.297601 | 2025-01-16 21:24:15.297700 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-16 21:24:15.700919 | ubuntu-noble | ok 2025-01-16 21:24:15.707369 | 2025-01-16 21:24:15.707463 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-16 21:24:15.770961 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:24:15.784316 | 2025-01-16 21:24:15.784429 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-16 21:24:16.207748 | ubuntu-noble | ok 2025-01-16 21:24:16.220465 | 2025-01-16 21:24:16.220572 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-16 21:24:16.249882 | ubuntu-noble | ok 2025-01-16 21:24:16.264866 | 2025-01-16 21:24:16.264963 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-16 21:24:16.584008 | ubuntu-noble -> localhost | ok 2025-01-16 21:24:16.591721 | 2025-01-16 21:24:16.591818 | TASK [validate-host : Collect information about the host] 2025-01-16 21:24:17.784619 | ubuntu-noble | ok 2025-01-16 21:24:17.800793 | 2025-01-16 21:24:17.800894 | TASK [validate-host : Sanitize hostname] 2025-01-16 21:24:17.860797 | ubuntu-noble | ok 2025-01-16 21:24:17.866585 | 2025-01-16 21:24:17.866675 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-16 21:24:18.373264 | ubuntu-noble -> localhost | changed 2025-01-16 21:24:18.387266 | 2025-01-16 21:24:18.387409 | TASK [validate-host : Collect information about zuul worker] 2025-01-16 21:24:18.841062 | ubuntu-noble | ok 2025-01-16 21:24:18.847528 | 2025-01-16 21:24:18.847624 | TASK [validate-host : Write out all zuul information for each host] 2025-01-16 21:24:19.341745 | ubuntu-noble -> localhost | changed 2025-01-16 21:24:19.387392 | 2025-01-16 21:24:19.387513 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-16 21:24:19.701174 | ubuntu-noble | ok 2025-01-16 21:24:19.708390 | 2025-01-16 21:24:19.708513 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-16 21:24:20.807191 | ubuntu-noble | changed: 2025-01-16 21:24:20.807377 | ubuntu-noble | cd+++++++++ src/ 2025-01-16 21:24:20.807632 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-16 21:24:20.807664 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-16 21:24:20.807687 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-16 21:24:20.807708 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.032653 2025-01-16 21:24:52.662306 | 2025-01-16 21:24:52.662416 | TASK [upload-logs : Upload logs to log server] 2025-01-16 21:24:53.267645 | localhost | Output suppressed because no_log was given 2025-01-16 21:24:53.270593 | 2025-01-16 21:24:53.270688 | LOOP [upload-logs : Compress console log and json output] 2025-01-16 21:24:53.327228 | localhost | skipping: Conditional result was False 2025-01-16 21:24:53.344300 | localhost | skipping: Conditional result was False 2025-01-16 21:24:53.354434 | 2025-01-16 21:24:53.354662 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-16 21:24:53.411837 | localhost | skipping: Conditional result was False 2025-01-16 21:24:53.412079 | 2025-01-16 21:24:53.424332 | localhost | skipping: Conditional result was False 2025-01-16 21:24:53.437144 | 2025-01-16 21:24:53.437242 | LOOP [upload-logs : Upload console log and json output]