2025-01-16 13:53:35.973618 | Job console starting... 2025-01-16 13:53:35.999131 | Updating repositories 2025-01-16 13:53:36.040431 | Preparing job workspace 2025-01-16 13:53:37.664927 | Running Ansible setup... 2025-01-16 13:53:42.830809 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-16 13:53:43.608605 | 2025-01-16 13:53:43.608779 | PLAY [Base pre] 2025-01-16 13:53:43.677939 | 2025-01-16 13:53:43.678121 | TASK [Setup log path fact] 2025-01-16 13:53:43.722489 | ubuntu-noble | ok 2025-01-16 13:53:43.769345 | 2025-01-16 13:53:43.769512 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 13:53:43.841244 | ubuntu-noble | ok 2025-01-16 13:53:43.856034 | 2025-01-16 13:53:43.856167 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 13:53:43.911705 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:43.921218 | 2025-01-16 13:53:43.921351 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 13:53:43.966513 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:43.974073 | 2025-01-16 13:53:43.974210 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 13:53:43.998697 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:44.006326 | 2025-01-16 13:53:44.006449 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 13:53:44.044969 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:44.054929 | 2025-01-16 13:53:44.055062 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 13:53:44.079902 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:44.095325 | 2025-01-16 13:53:44.095453 | TASK [emit-job-header : Print job information] 2025-01-16 13:53:44.146762 | # Job Information 2025-01-16 13:53:44.146945 | Ansible Version: 2.15.3 2025-01-16 13:53:44.146977 | Job: flake8 2025-01-16 13:53:44.147004 | Pipeline: check 2025-01-16 13:53:44.147024 | Executor: 7d211f194f6a 2025-01-16 13:53:44.147043 | Triggered by: https://github.com/osism/testbed/pull/2582 2025-01-16 13:53:44.147061 | Event ID: 437246f0-d411-11ef-927c-e5cc18cd984e 2025-01-16 13:53:44.153474 | 2025-01-16 13:53:44.153586 | LOOP [emit-job-header : Print node information] 2025-01-16 13:53:44.312210 | ubuntu-noble | ok: 2025-01-16 13:53:44.312396 | ubuntu-noble | # Node Information 2025-01-16 13:53:44.312428 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-16 13:53:44.312452 | ubuntu-noble | Hostname: ubuntu 2025-01-16 13:53:44.312473 | ubuntu-noble | Username: zuul 2025-01-16 13:53:44.312493 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-16 13:53:44.312512 | ubuntu-noble | Provider: regiocloud-a 2025-01-16 13:53:44.312532 | ubuntu-noble | Label: ubuntu-noble 2025-01-16 13:53:44.312551 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-16 13:53:44.312571 | ubuntu-noble | Interface IP: 81.163.193.209 2025-01-16 13:53:44.333495 | 2025-01-16 13:53:44.333635 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-16 13:53:44.838805 | ubuntu-noble -> localhost | changed 2025-01-16 13:53:44.847611 | 2025-01-16 13:53:44.847743 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-16 13:53:46.026552 | ubuntu-noble -> localhost | changed 2025-01-16 13:53:46.044328 | 2025-01-16 13:53:46.044452 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-16 13:53:46.394543 | ubuntu-noble -> localhost | ok 2025-01-16 13:53:46.408760 | 2025-01-16 13:53:46.408902 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-16 13:53:46.475696 | ubuntu-noble | ok 2025-01-16 13:53:46.493638 | ubuntu-noble | included: /var/lib/zuul/builds/7bd9c7ef7b0d4921a3288de754fd786c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-16 13:53:46.502103 | 2025-01-16 13:53:46.502220 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-16 13:53:47.817168 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-16 13:53:47.817447 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/7bd9c7ef7b0d4921a3288de754fd786c/work/7bd9c7ef7b0d4921a3288de754fd786c_id_rsa 2025-01-16 13:53:47.817489 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/7bd9c7ef7b0d4921a3288de754fd786c/work/7bd9c7ef7b0d4921a3288de754fd786c_id_rsa.pub 2025-01-16 13:53:47.817514 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-16 13:53:47.817538 | ubuntu-noble -> localhost | SHA256:82yNPYP0R6npAHQ5HQCsaysxiiBeULRAh0Dt+7nFMCA zuul-build-sshkey 2025-01-16 13:53:47.817561 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-16 13:53:47.817587 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-16 13:53:47.817609 | ubuntu-noble -> localhost | |=++o ...... | 2025-01-16 13:53:47.817629 | ubuntu-noble -> localhost | | .oo. . o . | 2025-01-16 13:53:47.817648 | ubuntu-noble -> localhost | | Eoo .. + . | 2025-01-16 13:53:47.817668 | ubuntu-noble -> localhost | | .... .. . . . | 2025-01-16 13:53:47.817687 | ubuntu-noble -> localhost | | . .o .S . o | 2025-01-16 13:53:47.817706 | ubuntu-noble -> localhost | |o oo * * * + | 2025-01-16 13:53:47.817726 | ubuntu-noble -> localhost | |+....+.+ B O . | 2025-01-16 13:53:47.817746 | ubuntu-noble -> localhost | |... .oo . o + | 2025-01-16 13:53:47.817765 | ubuntu-noble -> localhost | | o. . | 2025-01-16 13:53:47.817785 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-16 13:53:47.817832 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.781729 2025-01-16 13:53:47.827021 | 2025-01-16 13:53:47.827133 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-16 13:53:47.860377 | ubuntu-noble | ok 2025-01-16 13:53:47.871969 | ubuntu-noble | included: /var/lib/zuul/builds/7bd9c7ef7b0d4921a3288de754fd786c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-16 13:53:47.881822 | 2025-01-16 13:53:47.881964 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-16 13:53:47.909151 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:47.918423 | 2025-01-16 13:53:47.918538 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-16 13:53:48.647024 | ubuntu-noble | changed 2025-01-16 13:53:48.656353 | 2025-01-16 13:53:48.656476 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-16 13:53:48.984850 | ubuntu-noble | ok 2025-01-16 13:53:48.998048 | 2025-01-16 13:53:48.998181 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-16 13:53:49.722577 | ubuntu-noble | changed 2025-01-16 13:53:49.732283 | 2025-01-16 13:53:49.732403 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-16 13:53:50.454694 | ubuntu-noble | changed 2025-01-16 13:53:50.461766 | 2025-01-16 13:53:50.461893 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-16 13:53:50.505164 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:50.515228 | 2025-01-16 13:53:50.515380 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-16 13:53:51.001693 | ubuntu-noble -> localhost | changed 2025-01-16 13:53:51.016059 | 2025-01-16 13:53:51.016319 | TASK [add-build-sshkey : Add back temp key] 2025-01-16 13:53:51.415065 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/7bd9c7ef7b0d4921a3288de754fd786c/work/7bd9c7ef7b0d4921a3288de754fd786c_id_rsa (zuul-build-sshkey) 2025-01-16 13:53:51.415301 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017523 2025-01-16 13:53:51.456146 | 2025-01-16 13:53:51.456267 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-16 13:53:51.885516 | ubuntu-noble | ok 2025-01-16 13:53:51.897836 | 2025-01-16 13:53:51.898058 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-16 13:53:51.935705 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 13:53:51.955589 | 2025-01-16 13:53:51.955780 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-16 13:53:52.404273 | ubuntu-noble | ok 2025-01-16 13:53:52.434729 | 2025-01-16 13:53:52.434913 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-16 13:53:52.477854 | ubuntu-noble | ok 2025-01-16 13:53:52.485093 | 2025-01-16 13:53:52.485212 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-16 13:53:52.776632 | ubuntu-noble -> localhost | ok 2025-01-16 13:53:52.785115 | 2025-01-16 13:53:52.785230 | TASK [validate-host : Collect information about the host] 2025-01-16 13:53:54.002795 | ubuntu-noble | ok 2025-01-16 13:53:54.017471 | 2025-01-16 13:53:54.017607 | TASK [validate-host : Sanitize hostname] 2025-01-16 13:53:54.088653 | ubuntu-noble | ok 2025-01-16 13:53:54.095339 | 2025-01-16 13:53:54.095446 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-16 13:53:54.697035 | ubuntu-noble -> localhost | changed 2025-01-16 13:53:54.704805 | 2025-01-16 13:53:54.704966 | TASK [validate-host : Collect information about zuul worker] 2025-01-16 13:53:55.201366 | ubuntu-noble | ok 2025-01-16 13:53:55.211099 | 2025-01-16 13:53:55.212005 | TASK [validate-host : Write out all zuul information for each host] 2025-01-16 13:53:55.758001 | ubuntu-noble -> localhost | changed 2025-01-16 13:53:55.770926 | 2025-01-16 13:53:55.771051 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-16 13:53:56.081580 | ubuntu-noble | ok 2025-01-16 13:53:56.091355 | 2025-01-16 13:53:56.091474 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-16 13:53:57.400981 | ubuntu-noble | changed: 2025-01-16 13:53:57.401187 | ubuntu-noble | cd+++++++++ src/ 2025-01-16 13:53:57.401221 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-16 13:53:57.401246 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-16 13:53:57.401268 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-16 13:53:57.401288 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005127 2025-01-16 13:54:29.489343 | 2025-01-16 13:54:29.489484 | TASK [upload-logs : Upload logs to log server] 2025-01-16 13:54:30.286092 | localhost | Output suppressed because no_log was given 2025-01-16 13:54:30.289353 | 2025-01-16 13:54:30.289455 | LOOP [upload-logs : Compress console log and json output] 2025-01-16 13:54:30.356752 | localhost | skipping: Conditional result was False 2025-01-16 13:54:30.376087 | localhost | skipping: Conditional result was False 2025-01-16 13:54:30.388421 | 2025-01-16 13:54:30.388536 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-16 13:54:30.456667 | localhost | skipping: Conditional result was False 2025-01-16 13:54:30.457041 | 2025-01-16 13:54:30.471256 | localhost | skipping: Conditional result was False 2025-01-16 13:54:30.482152 | 2025-01-16 13:54:30.482337 | LOOP [upload-logs : Upload console log and json output]