2025-03-06 14:50:30.332242 | Job console starting... 2025-03-06 14:50:30.348385 | Updating repositories 2025-03-06 14:50:30.401163 | Preparing job workspace 2025-03-06 14:50:32.074639 | Running Ansible setup... 2025-03-06 14:50:37.582360 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-06 14:50:38.405821 | 2025-03-06 14:50:38.405978 | PLAY [Base pre] 2025-03-06 14:50:38.435416 | 2025-03-06 14:50:38.435612 | TASK [Setup log path fact] 2025-03-06 14:50:38.478614 | ubuntu-noble | ok 2025-03-06 14:50:38.502852 | 2025-03-06 14:50:38.502989 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-06 14:50:38.546381 | ubuntu-noble | ok 2025-03-06 14:50:38.553608 | 2025-03-06 14:50:38.553739 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-06 14:50:38.601201 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:38.608688 | 2025-03-06 14:50:38.608811 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-06 14:50:38.664266 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:38.671968 | 2025-03-06 14:50:38.672089 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-06 14:50:38.696841 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:38.704328 | 2025-03-06 14:50:38.704507 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-06 14:50:38.729827 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:38.737376 | 2025-03-06 14:50:38.737498 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-06 14:50:38.762744 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:38.778076 | 2025-03-06 14:50:38.778193 | TASK [emit-job-header : Print job information] 2025-03-06 14:50:38.842260 | # Job Information 2025-03-06 14:50:38.842443 | Ansible Version: 2.15.3 2025-03-06 14:50:38.842476 | Job: flake8 2025-03-06 14:50:38.842505 | Pipeline: check 2025-03-06 14:50:38.842525 | Executor: 7d211f194f6a 2025-03-06 14:50:38.842545 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-06 14:50:38.842577 | Event ID: 54e9c9d0-fa9a-11ef-9bad-0e22fcfd8f2f 2025-03-06 14:50:38.848985 | 2025-03-06 14:50:38.849094 | LOOP [emit-job-header : Print node information] 2025-03-06 14:50:39.011946 | ubuntu-noble | ok: 2025-03-06 14:50:39.012205 | ubuntu-noble | # Node Information 2025-03-06 14:50:39.012256 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-06 14:50:39.012289 | ubuntu-noble | Hostname: ubuntu 2025-03-06 14:50:39.012319 | ubuntu-noble | Username: zuul 2025-03-06 14:50:39.012347 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-06 14:50:39.012374 | ubuntu-noble | Provider: regiocloud-a 2025-03-06 14:50:39.012422 | ubuntu-noble | Label: ubuntu-noble 2025-03-06 14:50:39.012450 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-06 14:50:39.012479 | ubuntu-noble | Interface IP: 81.163.192.110 2025-03-06 14:50:39.027139 | 2025-03-06 14:50:39.027292 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-06 14:50:39.587331 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:39.595955 | 2025-03-06 14:50:39.596069 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-06 14:50:40.641357 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:40.654625 | 2025-03-06 14:50:40.654719 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-06 14:50:40.896945 | ubuntu-noble -> localhost | ok 2025-03-06 14:50:40.905166 | 2025-03-06 14:50:40.905263 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-06 14:50:40.934626 | ubuntu-noble | ok 2025-03-06 14:50:40.950204 | ubuntu-noble | included: /var/lib/zuul/builds/495a8db235d547828bc4039261dfcb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-06 14:50:40.957773 | 2025-03-06 14:50:40.957856 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-06 14:50:41.529486 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-06 14:50:41.529731 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/495a8db235d547828bc4039261dfcb9d/work/495a8db235d547828bc4039261dfcb9d_id_rsa 2025-03-06 14:50:41.529770 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/495a8db235d547828bc4039261dfcb9d/work/495a8db235d547828bc4039261dfcb9d_id_rsa.pub 2025-03-06 14:50:41.529796 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-06 14:50:41.529819 | ubuntu-noble -> localhost | SHA256:0FU2MfVnWMbbdJbnADfQ8+zmu1CL1UCNEz6i7hn585U zuul-build-sshkey 2025-03-06 14:50:41.529842 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-06 14:50:41.529866 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-06 14:50:41.529888 | ubuntu-noble -> localhost | | ..O**=+| 2025-03-06 14:50:41.529908 | ubuntu-noble -> localhost | | . . . **BB| 2025-03-06 14:50:41.529928 | ubuntu-noble -> localhost | | . . . =XO| 2025-03-06 14:50:41.529948 | ubuntu-noble -> localhost | | . . . =B| 2025-03-06 14:50:41.529967 | ubuntu-noble -> localhost | | S . +.| 2025-03-06 14:50:41.529987 | ubuntu-noble -> localhost | | . . + =| 2025-03-06 14:50:41.530006 | ubuntu-noble -> localhost | | + o E.| 2025-03-06 14:50:41.530026 | ubuntu-noble -> localhost | | . +. ...| 2025-03-06 14:50:41.530045 | ubuntu-noble -> localhost | | o .o.oo| 2025-03-06 14:50:41.530064 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-06 14:50:41.530109 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.150863 2025-03-06 14:50:41.537523 | 2025-03-06 14:50:41.537653 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-06 14:50:41.571009 | ubuntu-noble | ok 2025-03-06 14:50:41.582999 | ubuntu-noble | included: /var/lib/zuul/builds/495a8db235d547828bc4039261dfcb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-06 14:50:41.592528 | 2025-03-06 14:50:41.592647 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-06 14:50:41.627292 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:41.634347 | 2025-03-06 14:50:41.634437 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-06 14:50:42.434237 | ubuntu-noble | changed 2025-03-06 14:50:42.445090 | 2025-03-06 14:50:42.445197 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-06 14:50:42.764937 | ubuntu-noble | ok 2025-03-06 14:50:42.770539 | 2025-03-06 14:50:42.770623 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-06 14:50:43.572932 | ubuntu-noble | changed 2025-03-06 14:50:43.588168 | 2025-03-06 14:50:43.588491 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-06 14:50:44.416723 | ubuntu-noble | changed 2025-03-06 14:50:44.424265 | 2025-03-06 14:50:44.424372 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-06 14:50:44.451552 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:44.458730 | 2025-03-06 14:50:44.458817 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-06 14:50:44.826859 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:44.837768 | 2025-03-06 14:50:44.837852 | TASK [add-build-sshkey : Add back temp key] 2025-03-06 14:50:45.176501 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/495a8db235d547828bc4039261dfcb9d/work/495a8db235d547828bc4039261dfcb9d_id_rsa (zuul-build-sshkey) 2025-03-06 14:50:45.176719 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007551 2025-03-06 14:50:45.183940 | 2025-03-06 14:50:45.184030 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-06 14:50:45.627214 | ubuntu-noble | ok 2025-03-06 14:50:45.633357 | 2025-03-06 14:50:45.633442 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-06 14:50:45.657449 | ubuntu-noble | skipping: Conditional result was False 2025-03-06 14:50:45.670180 | 2025-03-06 14:50:45.670277 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-06 14:50:46.097817 | ubuntu-noble | ok 2025-03-06 14:50:46.110801 | 2025-03-06 14:50:46.110897 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-06 14:50:46.151242 | ubuntu-noble | ok 2025-03-06 14:50:46.157600 | 2025-03-06 14:50:46.157689 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-06 14:50:46.468608 | ubuntu-noble -> localhost | ok 2025-03-06 14:50:46.476015 | 2025-03-06 14:50:46.476111 | TASK [validate-host : Collect information about the host] 2025-03-06 14:50:47.747552 | ubuntu-noble | ok 2025-03-06 14:50:47.764861 | 2025-03-06 14:50:47.764965 | TASK [validate-host : Sanitize hostname] 2025-03-06 14:50:47.835287 | ubuntu-noble | ok 2025-03-06 14:50:47.845797 | 2025-03-06 14:50:47.845905 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-06 14:50:48.397867 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:48.405124 | 2025-03-06 14:50:48.405220 | TASK [validate-host : Collect information about zuul worker] 2025-03-06 14:50:48.903998 | ubuntu-noble | ok 2025-03-06 14:50:48.910131 | 2025-03-06 14:50:48.910225 | TASK [validate-host : Write out all zuul information for each host] 2025-03-06 14:50:49.471384 | ubuntu-noble -> localhost | changed 2025-03-06 14:50:49.484501 | 2025-03-06 14:50:49.484636 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-06 14:50:49.851007 | ubuntu-noble | ok 2025-03-06 14:50:49.861733 | 2025-03-06 14:50:49.861864 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-06 14:50:50.910459 | ubuntu-noble | changed: 2025-03-06 14:50:50.910788 | ubuntu-noble | cd+++++++++ src/ 2025-03-06 14:50:50.910834 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-06 14:50:50.910860 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-06 14:50:50.910883 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-06 14:50:50.910905 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009843 2025-03-06 14:51:26.648568 | 2025-03-06 14:51:26.648923 | TASK [upload-logs : Upload logs to log server] 2025-03-06 14:51:27.318371 | localhost | Output suppressed because no_log was given 2025-03-06 14:51:27.323609 | 2025-03-06 14:51:27.323770 | LOOP [upload-logs : Compress console log and json output] 2025-03-06 14:51:27.405251 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.423081 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.441009 | 2025-03-06 14:51:27.441227 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-06 14:51:27.513592 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.513905 | 2025-03-06 14:51:27.530309 | localhost | skipping: Conditional result was False 2025-03-06 14:51:27.548366 | 2025-03-06 14:51:27.548598 | LOOP [upload-logs : Upload console log and json output]