2025-03-19 22:57:42.796534 | Job console starting... 2025-03-19 22:57:42.812635 | Updating repositories 2025-03-19 22:57:42.834309 | Preparing job workspace 2025-03-19 22:57:45.039280 | Running Ansible setup... 2025-03-19 22:57:50.288362 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-19 22:57:50.996874 | 2025-03-19 22:57:50.997031 | PLAY [Base pre] 2025-03-19 22:57:51.044977 | 2025-03-19 22:57:51.045344 | TASK [Setup log path fact] 2025-03-19 22:57:51.090764 | ubuntu-noble | ok 2025-03-19 22:57:51.113521 | 2025-03-19 22:57:51.113693 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-19 22:57:51.165528 | ubuntu-noble | ok 2025-03-19 22:57:51.172588 | 2025-03-19 22:57:51.172718 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-19 22:57:51.218016 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.225765 | 2025-03-19 22:57:51.225921 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-19 22:57:51.279569 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.287264 | 2025-03-19 22:57:51.287397 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-19 22:57:51.331206 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.338803 | 2025-03-19 22:57:51.338940 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-19 22:57:51.364758 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.372326 | 2025-03-19 22:57:51.372484 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-19 22:57:51.397391 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.413083 | 2025-03-19 22:57:51.413239 | TASK [emit-job-header : Print job information] 2025-03-19 22:57:51.476288 | # Job Information 2025-03-19 22:57:51.476512 | Ansible Version: 2.15.3 2025-03-19 22:57:51.476547 | Job: flake8 2025-03-19 22:57:51.476577 | Pipeline: check 2025-03-19 22:57:51.476598 | Executor: 7d211f194f6a 2025-03-19 22:57:51.476617 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-19 22:57:51.476635 | Event ID: 8bee7cc0-0515-11f0-9eae-0ab3159231d7 2025-03-19 22:57:51.483230 | 2025-03-19 22:57:51.483354 | LOOP [emit-job-header : Print node information] 2025-03-19 22:57:51.637438 | ubuntu-noble | ok: 2025-03-19 22:57:51.637644 | ubuntu-noble | # Node Information 2025-03-19 22:57:51.637677 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-19 22:57:51.637702 | ubuntu-noble | Hostname: ubuntu 2025-03-19 22:57:51.637723 | ubuntu-noble | Username: zuul 2025-03-19 22:57:51.637759 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-19 22:57:51.637779 | ubuntu-noble | Provider: regiocloud-a 2025-03-19 22:57:51.637798 | ubuntu-noble | Label: ubuntu-noble 2025-03-19 22:57:51.637817 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-19 22:57:51.637838 | ubuntu-noble | Interface IP: 81.163.192.71 2025-03-19 22:57:51.663075 | 2025-03-19 22:57:51.663231 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-19 22:57:52.255831 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:52.265952 | 2025-03-19 22:57:52.266084 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-19 22:57:53.432056 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:53.447642 | 2025-03-19 22:57:53.447810 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-19 22:57:53.719456 | ubuntu-noble -> localhost | ok 2025-03-19 22:57:53.728585 | 2025-03-19 22:57:53.728725 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-19 22:57:53.759698 | ubuntu-noble | ok 2025-03-19 22:57:53.776561 | ubuntu-noble | included: /var/lib/zuul/builds/06825d5b1dfe49359fd24196b3fca097/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-19 22:57:53.784597 | 2025-03-19 22:57:53.784715 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-19 22:57:54.773681 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-19 22:57:54.773940 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/06825d5b1dfe49359fd24196b3fca097/work/06825d5b1dfe49359fd24196b3fca097_id_rsa 2025-03-19 22:57:54.773981 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/06825d5b1dfe49359fd24196b3fca097/work/06825d5b1dfe49359fd24196b3fca097_id_rsa.pub 2025-03-19 22:57:54.774005 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-19 22:57:54.774054 | ubuntu-noble -> localhost | SHA256:me/NL/vXw5oIpJr9pVLk2+HoK8x4ipIB539GcfoZdxM zuul-build-sshkey 2025-03-19 22:57:54.774077 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-19 22:57:54.774117 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-19 22:57:54.774140 | ubuntu-noble -> localhost | | | 2025-03-19 22:57:54.774161 | ubuntu-noble -> localhost | | | 2025-03-19 22:57:54.774194 | ubuntu-noble -> localhost | | | 2025-03-19 22:57:54.774215 | ubuntu-noble -> localhost | |. . . .+ E | 2025-03-19 22:57:54.774234 | ubuntu-noble -> localhost | |.o +S. . | 2025-03-19 22:57:54.774254 | ubuntu-noble -> localhost | | .. o ++..o | 2025-03-19 22:57:54.774289 | ubuntu-noble -> localhost | | o. .+o.=*o... .| 2025-03-19 22:57:54.774309 | ubuntu-noble -> localhost | | o o.**o++=o .oo| 2025-03-19 22:57:54.774329 | ubuntu-noble -> localhost | | .. *o.==o.+B+..| 2025-03-19 22:57:54.774363 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-19 22:57:54.774429 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.489962 2025-03-19 22:57:54.782009 | 2025-03-19 22:57:54.782101 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-19 22:57:54.812663 | ubuntu-noble | ok 2025-03-19 22:57:54.823285 | ubuntu-noble | included: /var/lib/zuul/builds/06825d5b1dfe49359fd24196b3fca097/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-19 22:57:54.832604 | 2025-03-19 22:57:54.832699 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-19 22:57:54.856338 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:54.863157 | 2025-03-19 22:57:54.863241 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-19 22:57:55.637981 | ubuntu-noble | changed 2025-03-19 22:57:55.648214 | 2025-03-19 22:57:55.648340 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-19 22:57:55.997965 | ubuntu-noble | ok 2025-03-19 22:57:56.004763 | 2025-03-19 22:57:56.004861 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-19 22:57:56.807112 | ubuntu-noble | changed 2025-03-19 22:57:56.817403 | 2025-03-19 22:57:56.817537 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-19 22:57:57.595777 | ubuntu-noble | changed 2025-03-19 22:57:57.604309 | 2025-03-19 22:57:57.604442 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-19 22:57:57.648459 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:57.655554 | 2025-03-19 22:57:57.655647 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-19 22:57:58.055908 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:58.068869 | 2025-03-19 22:57:58.068970 | TASK [add-build-sshkey : Add back temp key] 2025-03-19 22:57:58.418349 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/06825d5b1dfe49359fd24196b3fca097/work/06825d5b1dfe49359fd24196b3fca097_id_rsa (zuul-build-sshkey) 2025-03-19 22:57:58.418557 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008963 2025-03-19 22:57:58.452797 | 2025-03-19 22:57:58.452906 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-19 22:57:58.869606 | ubuntu-noble | ok 2025-03-19 22:57:58.879406 | 2025-03-19 22:57:58.879511 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-19 22:57:58.913586 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:58.928306 | 2025-03-19 22:57:58.928420 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-19 22:57:59.396997 | ubuntu-noble | ok 2025-03-19 22:57:59.410059 | 2025-03-19 22:57:59.410164 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-19 22:57:59.450327 | ubuntu-noble | ok 2025-03-19 22:57:59.456686 | 2025-03-19 22:57:59.456789 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-19 22:57:59.673433 | ubuntu-noble -> localhost | ok 2025-03-19 22:57:59.681021 | 2025-03-19 22:57:59.681202 | TASK [validate-host : Collect information about the host] 2025-03-19 22:58:00.934389 | ubuntu-noble | ok 2025-03-19 22:58:00.964565 | 2025-03-19 22:58:00.964678 | TASK [validate-host : Sanitize hostname] 2025-03-19 22:58:01.024365 | ubuntu-noble | ok 2025-03-19 22:58:01.030376 | 2025-03-19 22:58:01.030474 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-19 22:58:01.628784 | ubuntu-noble -> localhost | changed 2025-03-19 22:58:01.647052 | 2025-03-19 22:58:01.647172 | TASK [validate-host : Collect information about zuul worker] 2025-03-19 22:58:02.173050 | ubuntu-noble | ok 2025-03-19 22:58:02.181564 | 2025-03-19 22:58:02.181666 | TASK [validate-host : Write out all zuul information for each host] 2025-03-19 22:58:02.675890 | ubuntu-noble -> localhost | changed 2025-03-19 22:58:02.687430 | 2025-03-19 22:58:02.687519 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-19 22:58:03.038263 | ubuntu-noble | ok 2025-03-19 22:58:03.048917 | 2025-03-19 22:58:03.049071 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-19 22:58:04.448303 | ubuntu-noble | changed: 2025-03-19 22:58:04.448567 | ubuntu-noble | cd+++++++++ src/ 2025-03-19 22:58:04.448609 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-19 22:58:04.448639 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-19 22:58:04.448665 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-19 22:58:04.448690 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004711 2025-03-19 22:58:43.791830 | 2025-03-19 22:58:43.791966 | TASK [upload-logs : Upload logs to log server] 2025-03-19 22:58:44.402278 | localhost | Output suppressed because no_log was given 2025-03-19 22:58:44.407032 | 2025-03-19 22:58:44.407160 | LOOP [upload-logs : Compress console log and json output] 2025-03-19 22:58:44.482362 | localhost | skipping: Conditional result was False 2025-03-19 22:58:44.505979 | localhost | skipping: Conditional result was False 2025-03-19 22:58:44.518970 | 2025-03-19 22:58:44.519092 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-19 22:58:44.581179 | localhost | skipping: Conditional result was False 2025-03-19 22:58:44.581542 | 2025-03-19 22:58:44.597248 | localhost | skipping: Conditional result was False 2025-03-19 22:58:44.609176 | 2025-03-19 22:58:44.609298 | LOOP [upload-logs : Upload console log and json output]