2025-03-12 00:06:46.101988 | Job console starting... 2025-03-12 00:06:46.113313 | Updating repositories 2025-03-12 00:06:46.138607 | Preparing job workspace 2025-03-12 00:06:47.729445 | Running Ansible setup... 2025-03-12 00:06:53.025878 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-12 00:06:53.811464 | 2025-03-12 00:06:53.811626 | PLAY [Base pre] 2025-03-12 00:06:53.855967 | 2025-03-12 00:06:53.856128 | TASK [Setup log path fact] 2025-03-12 00:06:53.888560 | ubuntu-noble | ok 2025-03-12 00:06:53.914807 | 2025-03-12 00:06:53.914965 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 00:06:53.967338 | ubuntu-noble | ok 2025-03-12 00:06:53.974688 | 2025-03-12 00:06:53.974808 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 00:06:54.009460 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.017647 | 2025-03-12 00:06:54.017930 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 00:06:54.062737 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.072535 | 2025-03-12 00:06:54.072677 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 00:06:54.097967 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.105410 | 2025-03-12 00:06:54.105520 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 00:06:54.130317 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.138506 | 2025-03-12 00:06:54.138625 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 00:06:54.162979 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:54.179704 | 2025-03-12 00:06:54.179821 | TASK [emit-job-header : Print job information] 2025-03-12 00:06:54.242715 | # Job Information 2025-03-12 00:06:54.242897 | Ansible Version: 2.15.3 2025-03-12 00:06:54.242929 | Job: flake8 2025-03-12 00:06:54.242959 | Pipeline: check 2025-03-12 00:06:54.242980 | Executor: 7d211f194f6a 2025-03-12 00:06:54.243000 | Triggered by: https://github.com/osism/testbed/pull/2619 2025-03-12 00:06:54.243018 | Event ID: de0cba80-fed5-11ef-862a-57d26c0a08b3 2025-03-12 00:06:54.250042 | 2025-03-12 00:06:54.250153 | LOOP [emit-job-header : Print node information] 2025-03-12 00:06:54.406043 | ubuntu-noble | ok: 2025-03-12 00:06:54.406231 | ubuntu-noble | # Node Information 2025-03-12 00:06:54.406265 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-12 00:06:54.406290 | ubuntu-noble | Hostname: ubuntu 2025-03-12 00:06:54.406313 | ubuntu-noble | Username: zuul 2025-03-12 00:06:54.406333 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-12 00:06:54.406354 | ubuntu-noble | Provider: regiocloud-a 2025-03-12 00:06:54.406374 | ubuntu-noble | Label: ubuntu-noble 2025-03-12 00:06:54.406393 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-12 00:06:54.406414 | ubuntu-noble | Interface IP: 81.163.192.58 2025-03-12 00:06:54.427611 | 2025-03-12 00:06:54.427756 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-12 00:06:54.942168 | ubuntu-noble -> localhost | changed 2025-03-12 00:06:54.950995 | 2025-03-12 00:06:54.951114 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-12 00:06:56.168702 | ubuntu-noble -> localhost | changed 2025-03-12 00:06:56.185392 | 2025-03-12 00:06:56.185522 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-12 00:06:56.603321 | ubuntu-noble -> localhost | ok 2025-03-12 00:06:56.613428 | 2025-03-12 00:06:56.613570 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-12 00:06:56.646535 | ubuntu-noble | ok 2025-03-12 00:06:56.665521 | ubuntu-noble | included: /var/lib/zuul/builds/e038e65ac03e40198350da9c56356f61/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-12 00:06:56.674080 | 2025-03-12 00:06:56.674191 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-12 00:06:57.437004 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-12 00:06:57.437270 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e038e65ac03e40198350da9c56356f61/work/e038e65ac03e40198350da9c56356f61_id_rsa 2025-03-12 00:06:57.437311 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e038e65ac03e40198350da9c56356f61/work/e038e65ac03e40198350da9c56356f61_id_rsa.pub 2025-03-12 00:06:57.437338 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-12 00:06:57.437362 | ubuntu-noble -> localhost | SHA256:XZEFzz3JZQWa3SD2ijy29imN3l7m+ugZRRSw3fH0EQ8 zuul-build-sshkey 2025-03-12 00:06:57.437386 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-12 00:06:57.437412 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-12 00:06:57.437434 | ubuntu-noble -> localhost | | *=E*B| 2025-03-12 00:06:57.437455 | ubuntu-noble -> localhost | | ..&.OO| 2025-03-12 00:06:57.437475 | ubuntu-noble -> localhost | | = B+B| 2025-03-12 00:06:57.437496 | ubuntu-noble -> localhost | | o o o .| 2025-03-12 00:06:57.437515 | ubuntu-noble -> localhost | | S * . . | 2025-03-12 00:06:57.437535 | ubuntu-noble -> localhost | | . o . | 2025-03-12 00:06:57.437556 | ubuntu-noble -> localhost | | oo. o | 2025-03-12 00:06:57.437577 | ubuntu-noble -> localhost | | .oo.O | 2025-03-12 00:06:57.437596 | ubuntu-noble -> localhost | | ..+Xoo | 2025-03-12 00:06:57.437616 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-12 00:06:57.437713 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.210583 2025-03-12 00:06:57.445818 | 2025-03-12 00:06:57.445942 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-12 00:06:57.479844 | ubuntu-noble | ok 2025-03-12 00:06:57.500984 | ubuntu-noble | included: /var/lib/zuul/builds/e038e65ac03e40198350da9c56356f61/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-12 00:06:57.511057 | 2025-03-12 00:06:57.511167 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-12 00:06:57.540806 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:06:57.551507 | 2025-03-12 00:06:57.551625 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-12 00:06:58.378534 | ubuntu-noble | changed 2025-03-12 00:06:58.391257 | 2025-03-12 00:06:58.391405 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-12 00:06:58.724000 | ubuntu-noble | ok 2025-03-12 00:06:58.731913 | 2025-03-12 00:06:58.732022 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-12 00:06:59.635720 | ubuntu-noble | changed 2025-03-12 00:06:59.647127 | 2025-03-12 00:06:59.647248 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-12 00:07:00.390339 | ubuntu-noble | changed 2025-03-12 00:07:00.400100 | 2025-03-12 00:07:00.400225 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-12 00:07:00.439300 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:07:00.458627 | 2025-03-12 00:07:00.458841 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-12 00:07:00.927488 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:00.944101 | 2025-03-12 00:07:00.944227 | TASK [add-build-sshkey : Add back temp key] 2025-03-12 00:07:01.445810 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e038e65ac03e40198350da9c56356f61/work/e038e65ac03e40198350da9c56356f61_id_rsa (zuul-build-sshkey) 2025-03-12 00:07:01.446061 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013631 2025-03-12 00:07:01.498756 | 2025-03-12 00:07:01.498893 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-12 00:07:01.917842 | ubuntu-noble | ok 2025-03-12 00:07:01.927479 | 2025-03-12 00:07:01.927609 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-12 00:07:01.963163 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 00:07:01.985249 | 2025-03-12 00:07:01.985510 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-12 00:07:02.448946 | ubuntu-noble | ok 2025-03-12 00:07:02.466830 | 2025-03-12 00:07:02.466969 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-12 00:07:02.536593 | ubuntu-noble | ok 2025-03-12 00:07:02.543846 | 2025-03-12 00:07:02.544086 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-12 00:07:02.906788 | ubuntu-noble -> localhost | ok 2025-03-12 00:07:02.915084 | 2025-03-12 00:07:02.915353 | TASK [validate-host : Collect information about the host] 2025-03-12 00:07:04.191169 | ubuntu-noble | ok 2025-03-12 00:07:04.204039 | 2025-03-12 00:07:04.204154 | TASK [validate-host : Sanitize hostname] 2025-03-12 00:07:04.294413 | ubuntu-noble | ok 2025-03-12 00:07:04.301063 | 2025-03-12 00:07:04.301176 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-12 00:07:04.917085 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:04.931191 | 2025-03-12 00:07:04.931319 | TASK [validate-host : Collect information about zuul worker] 2025-03-12 00:07:05.493774 | ubuntu-noble | ok 2025-03-12 00:07:05.504790 | 2025-03-12 00:07:05.504923 | TASK [validate-host : Write out all zuul information for each host] 2025-03-12 00:07:06.279809 | ubuntu-noble -> localhost | changed 2025-03-12 00:07:06.293392 | 2025-03-12 00:07:06.293510 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-12 00:07:06.660914 | ubuntu-noble | ok 2025-03-12 00:07:06.667650 | 2025-03-12 00:07:06.667753 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-12 00:07:07.797357 | ubuntu-noble | changed: 2025-03-12 00:07:07.797515 | ubuntu-noble | cd+++++++++ src/ 2025-03-12 00:07:07.797548 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-12 00:07:07.797573 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-12 00:07:07.797594 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-12 00:07:07.797615 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005286 2025-03-12 00:07:44.392107 | 2025-03-12 00:07:44.392224 | TASK [upload-logs : Upload logs to log server] 2025-03-12 00:07:44.974288 | localhost | Output suppressed because no_log was given 2025-03-12 00:07:44.977510 | 2025-03-12 00:07:44.977619 | LOOP [upload-logs : Compress console log and json output] 2025-03-12 00:07:45.046760 | localhost | skipping: Conditional result was False 2025-03-12 00:07:45.064797 | localhost | skipping: Conditional result was False 2025-03-12 00:07:45.074189 | 2025-03-12 00:07:45.074338 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-12 00:07:45.145220 | localhost | skipping: Conditional result was False 2025-03-12 00:07:45.145619 | 2025-03-12 00:07:45.161403 | localhost | skipping: Conditional result was False 2025-03-12 00:07:45.178342 | 2025-03-12 00:07:45.178506 | LOOP [upload-logs : Upload console log and json output]