2025-03-11 16:43:47.794418 | Job console starting... 2025-03-11 16:43:47.818003 | Updating repositories 2025-03-11 16:43:47.864379 | Preparing job workspace 2025-03-11 16:43:50.000052 | Running Ansible setup... 2025-03-11 16:43:55.358177 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-11 16:43:56.052905 | 2025-03-11 16:43:56.053087 | PLAY [Base pre] 2025-03-11 16:43:56.082565 | 2025-03-11 16:43:56.082723 | TASK [Setup log path fact] 2025-03-11 16:43:56.114410 | ubuntu-noble | ok 2025-03-11 16:43:56.136775 | 2025-03-11 16:43:56.136929 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-11 16:43:56.209793 | ubuntu-noble | ok 2025-03-11 16:43:56.220675 | 2025-03-11 16:43:56.220832 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-11 16:43:56.296248 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:56.303707 | 2025-03-11 16:43:56.303852 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-11 16:43:56.348699 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:56.356225 | 2025-03-11 16:43:56.356345 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-11 16:43:56.380669 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:56.388166 | 2025-03-11 16:43:56.388283 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-11 16:43:56.412402 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:56.419794 | 2025-03-11 16:43:56.419913 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-11 16:43:56.443935 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:56.459018 | 2025-03-11 16:43:56.459141 | TASK [emit-job-header : Print job information] 2025-03-11 16:43:56.530716 | # Job Information 2025-03-11 16:43:56.530910 | Ansible Version: 2.15.3 2025-03-11 16:43:56.530942 | Job: flake8 2025-03-11 16:43:56.530970 | Pipeline: check 2025-03-11 16:43:56.530990 | Executor: 7d211f194f6a 2025-03-11 16:43:56.531009 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-11 16:43:56.531027 | Event ID: fc220720-fe97-11ef-9a2c-037f33f55ef7 2025-03-11 16:43:56.537433 | 2025-03-11 16:43:56.537546 | LOOP [emit-job-header : Print node information] 2025-03-11 16:43:56.681424 | ubuntu-noble | ok: 2025-03-11 16:43:56.681696 | ubuntu-noble | # Node Information 2025-03-11 16:43:56.681734 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-11 16:43:56.681810 | ubuntu-noble | Hostname: ubuntu 2025-03-11 16:43:56.681832 | ubuntu-noble | Username: zuul 2025-03-11 16:43:56.681853 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-11 16:43:56.681873 | ubuntu-noble | Provider: regiocloud-a 2025-03-11 16:43:56.681893 | ubuntu-noble | Label: ubuntu-noble 2025-03-11 16:43:56.681912 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-11 16:43:56.681931 | ubuntu-noble | Interface IP: 81.163.192.148 2025-03-11 16:43:56.698170 | 2025-03-11 16:43:56.698288 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-11 16:43:57.224722 | ubuntu-noble -> localhost | changed 2025-03-11 16:43:57.233197 | 2025-03-11 16:43:57.233315 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-11 16:43:58.322384 | ubuntu-noble -> localhost | changed 2025-03-11 16:43:58.336518 | 2025-03-11 16:43:58.336640 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-11 16:43:58.715333 | ubuntu-noble -> localhost | ok 2025-03-11 16:43:58.724107 | 2025-03-11 16:43:58.724232 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-11 16:43:58.764839 | ubuntu-noble | ok 2025-03-11 16:43:58.782251 | ubuntu-noble | included: /var/lib/zuul/builds/a6019001af9441d3b85f6b05600587a3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-11 16:43:58.809682 | 2025-03-11 16:43:58.809832 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-11 16:43:59.483719 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-11 16:43:59.484103 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6019001af9441d3b85f6b05600587a3/work/a6019001af9441d3b85f6b05600587a3_id_rsa 2025-03-11 16:43:59.484203 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6019001af9441d3b85f6b05600587a3/work/a6019001af9441d3b85f6b05600587a3_id_rsa.pub 2025-03-11 16:43:59.484258 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-11 16:43:59.484306 | ubuntu-noble -> localhost | SHA256:vCaVyUVPtRHPm7r0dA2nMdNPfAZPIlCd2sk+qsYODgA zuul-build-sshkey 2025-03-11 16:43:59.484353 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-11 16:43:59.484428 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-11 16:43:59.484475 | ubuntu-noble -> localhost | | o.oo+o | 2025-03-11 16:43:59.484518 | ubuntu-noble -> localhost | | . + o= | 2025-03-11 16:43:59.484559 | ubuntu-noble -> localhost | | E . o++.+| 2025-03-11 16:43:59.484599 | ubuntu-noble -> localhost | | . o + ..+Bo| 2025-03-11 16:43:59.484638 | ubuntu-noble -> localhost | | . S .=oO| 2025-03-11 16:43:59.484676 | ubuntu-noble -> localhost | | . . . +X+| 2025-03-11 16:43:59.484716 | ubuntu-noble -> localhost | | o +. +.o+| 2025-03-11 16:43:59.484795 | ubuntu-noble -> localhost | | = .o o + .| 2025-03-11 16:43:59.484839 | ubuntu-noble -> localhost | | .oo. . . | 2025-03-11 16:43:59.484879 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-11 16:43:59.484975 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.143506 2025-03-11 16:43:59.499769 | 2025-03-11 16:43:59.499929 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-11 16:43:59.540458 | ubuntu-noble | ok 2025-03-11 16:43:59.552040 | ubuntu-noble | included: /var/lib/zuul/builds/a6019001af9441d3b85f6b05600587a3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-11 16:43:59.561903 | 2025-03-11 16:43:59.562003 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-11 16:43:59.586044 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:43:59.593594 | 2025-03-11 16:43:59.593702 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-11 16:44:00.505873 | ubuntu-noble | changed 2025-03-11 16:44:00.515186 | 2025-03-11 16:44:00.515308 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-11 16:44:00.876208 | ubuntu-noble | ok 2025-03-11 16:44:00.888357 | 2025-03-11 16:44:00.888556 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-11 16:44:01.736329 | ubuntu-noble | changed 2025-03-11 16:44:01.745367 | 2025-03-11 16:44:01.745495 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-11 16:44:02.584332 | ubuntu-noble | changed 2025-03-11 16:44:02.607194 | 2025-03-11 16:44:02.607331 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-11 16:44:02.632853 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:44:02.641222 | 2025-03-11 16:44:02.641338 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-11 16:44:03.140809 | ubuntu-noble -> localhost | changed 2025-03-11 16:44:03.155516 | 2025-03-11 16:44:03.155700 | TASK [add-build-sshkey : Add back temp key] 2025-03-11 16:44:03.558765 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a6019001af9441d3b85f6b05600587a3/work/a6019001af9441d3b85f6b05600587a3_id_rsa (zuul-build-sshkey) 2025-03-11 16:44:03.559001 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008363 2025-03-11 16:44:03.599810 | 2025-03-11 16:44:03.599948 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-11 16:44:04.060690 | ubuntu-noble | ok 2025-03-11 16:44:04.069304 | 2025-03-11 16:44:04.069436 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-11 16:44:04.104916 | ubuntu-noble | skipping: Conditional result was False 2025-03-11 16:44:04.132076 | 2025-03-11 16:44:04.132234 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-11 16:44:04.583299 | ubuntu-noble | ok 2025-03-11 16:44:04.599503 | 2025-03-11 16:44:04.599658 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-11 16:44:04.646869 | ubuntu-noble | ok 2025-03-11 16:44:04.654277 | 2025-03-11 16:44:04.654387 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-11 16:44:04.974459 | ubuntu-noble -> localhost | ok 2025-03-11 16:44:04.982667 | 2025-03-11 16:44:04.982820 | TASK [validate-host : Collect information about the host] 2025-03-11 16:44:06.299495 | ubuntu-noble | ok 2025-03-11 16:44:06.315553 | 2025-03-11 16:44:06.315677 | TASK [validate-host : Sanitize hostname] 2025-03-11 16:44:06.402861 | ubuntu-noble | ok 2025-03-11 16:44:06.409293 | 2025-03-11 16:44:06.409413 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-11 16:44:07.035716 | ubuntu-noble -> localhost | changed 2025-03-11 16:44:07.044292 | 2025-03-11 16:44:07.044455 | TASK [validate-host : Collect information about zuul worker] 2025-03-11 16:44:07.601475 | ubuntu-noble | ok 2025-03-11 16:44:07.609659 | 2025-03-11 16:44:07.609842 | TASK [validate-host : Write out all zuul information for each host] 2025-03-11 16:44:08.154446 | ubuntu-noble -> localhost | changed 2025-03-11 16:44:08.167276 | 2025-03-11 16:44:08.167402 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-11 16:44:08.565298 | ubuntu-noble | ok 2025-03-11 16:44:08.576864 | 2025-03-11 16:44:08.577019 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-11 16:44:10.065207 | ubuntu-noble | changed: 2025-03-11 16:44:10.065400 | ubuntu-noble | cd+++++++++ src/ 2025-03-11 16:44:10.065433 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-11 16:44:10.065457 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-11 16:44:10.065479 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-11 16:44:10.065499 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004449 2025-03-11 16:44:46.382027 | 2025-03-11 16:44:46.382185 | TASK [upload-logs : Upload logs to log server] 2025-03-11 16:44:46.935677 | localhost | Output suppressed because no_log was given 2025-03-11 16:44:46.939984 | 2025-03-11 16:44:46.940120 | LOOP [upload-logs : Compress console log and json output] 2025-03-11 16:44:47.031703 | localhost | skipping: Conditional result was False 2025-03-11 16:44:47.050996 | localhost | skipping: Conditional result was False 2025-03-11 16:44:47.062990 | 2025-03-11 16:44:47.063210 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-11 16:44:47.126675 | localhost | skipping: Conditional result was False 2025-03-11 16:44:47.126997 | 2025-03-11 16:44:47.142950 | localhost | skipping: Conditional result was False 2025-03-11 16:44:47.155333 | 2025-03-11 16:44:47.155579 | LOOP [upload-logs : Upload console log and json output]