2025-01-22 15:34:44.362348 | Job console starting... 2025-01-22 15:34:44.395148 | Updating repositories 2025-01-22 15:34:44.440284 | Preparing job workspace 2025-01-22 15:34:46.567104 | Running Ansible setup... 2025-01-22 15:34:51.530171 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-22 15:34:52.300013 | 2025-01-22 15:34:52.300180 | PLAY [Base pre] 2025-01-22 15:34:52.331007 | 2025-01-22 15:34:52.331166 | TASK [Setup log path fact] 2025-01-22 15:34:52.374113 | ubuntu-noble | ok 2025-01-22 15:34:52.396540 | 2025-01-22 15:34:52.396702 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 15:34:52.439280 | ubuntu-noble | ok 2025-01-22 15:34:52.449547 | 2025-01-22 15:34:52.449673 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 15:34:52.484049 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.491713 | 2025-01-22 15:34:52.491850 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 15:34:52.547110 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.554959 | 2025-01-22 15:34:52.555095 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 15:34:52.583758 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.591515 | 2025-01-22 15:34:52.591641 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 15:34:52.626361 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.634058 | 2025-01-22 15:34:52.634182 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 15:34:52.658667 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:52.674576 | 2025-01-22 15:34:52.674724 | TASK [emit-job-header : Print job information] 2025-01-22 15:34:52.747005 | # Job Information 2025-01-22 15:34:52.747183 | Ansible Version: 2.15.3 2025-01-22 15:34:52.747214 | Job: flake8 2025-01-22 15:34:52.747242 | Pipeline: check 2025-01-22 15:34:52.747280 | Executor: 7d211f194f6a 2025-01-22 15:34:52.747300 | Triggered by: https://github.com/osism/testbed/pull/2592 2025-01-22 15:34:52.747319 | Event ID: 622e57e0-d8d6-11ef-8c48-e5f0b0dd580c 2025-01-22 15:34:52.753912 | 2025-01-22 15:34:52.754023 | LOOP [emit-job-header : Print node information] 2025-01-22 15:34:52.926287 | ubuntu-noble | ok: 2025-01-22 15:34:52.926476 | ubuntu-noble | # Node Information 2025-01-22 15:34:52.926508 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-22 15:34:52.926532 | ubuntu-noble | Hostname: ubuntu 2025-01-22 15:34:52.926553 | ubuntu-noble | Username: zuul 2025-01-22 15:34:52.926573 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-22 15:34:52.926592 | ubuntu-noble | Provider: regiocloud-a 2025-01-22 15:34:52.926612 | ubuntu-noble | Label: ubuntu-noble 2025-01-22 15:34:52.926631 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-22 15:34:52.926651 | ubuntu-noble | Interface IP: 81.163.193.129 2025-01-22 15:34:52.969422 | 2025-01-22 15:34:52.969567 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-22 15:34:53.541118 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:53.549805 | 2025-01-22 15:34:53.549933 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-22 15:34:54.632072 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:54.646842 | 2025-01-22 15:34:54.646975 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-22 15:34:54.947366 | ubuntu-noble -> localhost | ok 2025-01-22 15:34:54.956352 | 2025-01-22 15:34:54.956497 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-22 15:34:55.003552 | ubuntu-noble | ok 2025-01-22 15:34:55.021980 | ubuntu-noble | included: /var/lib/zuul/builds/89338045eccd42aeb7913059a0026f0d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-22 15:34:55.029956 | 2025-01-22 15:34:55.030070 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-22 15:34:55.837296 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-22 15:34:55.837568 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/89338045eccd42aeb7913059a0026f0d/work/89338045eccd42aeb7913059a0026f0d_id_rsa 2025-01-22 15:34:55.837644 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/89338045eccd42aeb7913059a0026f0d/work/89338045eccd42aeb7913059a0026f0d_id_rsa.pub 2025-01-22 15:34:55.837672 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-22 15:34:55.837694 | ubuntu-noble -> localhost | SHA256:jwVfyghCPHYLlBGOeT6Hfovf+kiURZOZguRdPPxmxUo zuul-build-sshkey 2025-01-22 15:34:55.837716 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-22 15:34:55.837740 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-22 15:34:55.837762 | ubuntu-noble -> localhost | | +*= o++ . | 2025-01-22 15:34:55.837783 | ubuntu-noble -> localhost | | *B.ooB.E o | 2025-01-22 15:34:55.837802 | ubuntu-noble -> localhost | | o.=+ooo+ o. | 2025-01-22 15:34:55.837821 | ubuntu-noble -> localhost | | o o.+ ==o | 2025-01-22 15:34:55.837841 | ubuntu-noble -> localhost | | + + So= | 2025-01-22 15:34:55.837860 | ubuntu-noble -> localhost | | . + + | 2025-01-22 15:34:55.837879 | ubuntu-noble -> localhost | | . o . . | 2025-01-22 15:34:55.837898 | ubuntu-noble -> localhost | | + + | 2025-01-22 15:34:55.837918 | ubuntu-noble -> localhost | | ..=oo | 2025-01-22 15:34:55.837937 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-22 15:34:55.837988 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.288955 2025-01-22 15:34:55.846180 | 2025-01-22 15:34:55.846326 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-22 15:34:55.882268 | ubuntu-noble | ok 2025-01-22 15:34:55.894183 | ubuntu-noble | included: /var/lib/zuul/builds/89338045eccd42aeb7913059a0026f0d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-22 15:34:55.904766 | 2025-01-22 15:34:55.904895 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-22 15:34:55.929984 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:55.937633 | 2025-01-22 15:34:55.937752 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-22 15:34:56.763022 | ubuntu-noble | changed 2025-01-22 15:34:56.774341 | 2025-01-22 15:34:56.774474 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-22 15:34:57.080775 | ubuntu-noble | ok 2025-01-22 15:34:57.091351 | 2025-01-22 15:34:57.091495 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-22 15:34:57.806170 | ubuntu-noble | changed 2025-01-22 15:34:57.816021 | 2025-01-22 15:34:57.816295 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-22 15:34:58.547879 | ubuntu-noble | changed 2025-01-22 15:34:58.558884 | 2025-01-22 15:34:58.559023 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-22 15:34:58.584129 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:58.592015 | 2025-01-22 15:34:58.592754 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-22 15:34:59.034968 | ubuntu-noble -> localhost | changed 2025-01-22 15:34:59.055172 | 2025-01-22 15:34:59.055385 | TASK [add-build-sshkey : Add back temp key] 2025-01-22 15:34:59.392215 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/89338045eccd42aeb7913059a0026f0d/work/89338045eccd42aeb7913059a0026f0d_id_rsa (zuul-build-sshkey) 2025-01-22 15:34:59.392860 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009567 2025-01-22 15:34:59.403104 | 2025-01-22 15:34:59.403230 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-22 15:34:59.878032 | ubuntu-noble | ok 2025-01-22 15:34:59.886416 | 2025-01-22 15:34:59.886560 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-22 15:34:59.922304 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 15:34:59.946428 | 2025-01-22 15:34:59.946590 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-22 15:35:00.384235 | ubuntu-noble | ok 2025-01-22 15:35:00.402135 | 2025-01-22 15:35:00.402300 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-22 15:35:00.444960 | ubuntu-noble | ok 2025-01-22 15:35:00.459951 | 2025-01-22 15:35:00.460091 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-22 15:35:00.825367 | ubuntu-noble -> localhost | ok 2025-01-22 15:35:00.833536 | 2025-01-22 15:35:00.833659 | TASK [validate-host : Collect information about the host] 2025-01-22 15:35:02.038187 | ubuntu-noble | ok 2025-01-22 15:35:02.069964 | 2025-01-22 15:35:02.070118 | TASK [validate-host : Sanitize hostname] 2025-01-22 15:35:02.164578 | ubuntu-noble | ok 2025-01-22 15:35:02.175660 | 2025-01-22 15:35:02.175789 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-22 15:35:02.733650 | ubuntu-noble -> localhost | changed 2025-01-22 15:35:02.740906 | 2025-01-22 15:35:02.741033 | TASK [validate-host : Collect information about zuul worker] 2025-01-22 15:35:03.216100 | ubuntu-noble | ok 2025-01-22 15:35:03.229973 | 2025-01-22 15:35:03.230104 | TASK [validate-host : Write out all zuul information for each host] 2025-01-22 15:35:03.849503 | ubuntu-noble -> localhost | changed 2025-01-22 15:35:03.872923 | 2025-01-22 15:35:03.873118 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-22 15:35:04.206361 | ubuntu-noble | ok 2025-01-22 15:35:04.216694 | 2025-01-22 15:35:04.216832 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-22 15:35:05.540223 | ubuntu-noble | changed: 2025-01-22 15:35:05.542681 | ubuntu-noble | cd+++++++++ src/ 2025-01-22 15:35:05.542744 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-22 15:35:05.542769 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-22 15:35:05.542790 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-22 15:35:05.542811 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.028231 2025-01-22 15:35:40.091670 | 2025-01-22 15:35:40.091799 | TASK [upload-logs : Upload logs to log server] 2025-01-22 15:35:40.781691 | localhost | Output suppressed because no_log was given 2025-01-22 15:35:40.785390 | 2025-01-22 15:35:40.785506 | LOOP [upload-logs : Compress console log and json output] 2025-01-22 15:35:40.871737 | localhost | skipping: Conditional result was False 2025-01-22 15:35:40.894926 | localhost | skipping: Conditional result was False 2025-01-22 15:35:40.907103 | 2025-01-22 15:35:40.907245 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-22 15:35:40.979537 | localhost | skipping: Conditional result was False 2025-01-22 15:35:40.979860 | 2025-01-22 15:35:40.991965 | localhost | skipping: Conditional result was False 2025-01-22 15:35:40.997482 | 2025-01-22 15:35:40.997618 | LOOP [upload-logs : Upload console log and json output]