2025-05-08 12:18:19.350286 | Job console starting... 2025-05-08 12:18:19.384800 | Updating repositories 2025-05-08 12:18:19.411802 | Preparing job workspace 2025-05-08 12:18:20.961059 | Running Ansible setup... 2025-05-08 12:18:25.545302 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-08 12:18:26.229657 | 2025-05-08 12:18:26.229819 | PLAY [Base pre] 2025-05-08 12:18:26.259654 | 2025-05-08 12:18:26.259805 | TASK [Setup log path fact] 2025-05-08 12:18:26.301418 | ubuntu-noble | ok 2025-05-08 12:18:26.320428 | 2025-05-08 12:18:26.320624 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-08 12:18:26.361791 | ubuntu-noble | ok 2025-05-08 12:18:26.375052 | 2025-05-08 12:18:26.375186 | TASK [emit-job-header : Print job information] 2025-05-08 12:18:26.428585 | # Job Information 2025-05-08 12:18:26.428830 | Ansible Version: 2.15.3 2025-05-08 12:18:26.428870 | Job: python-black 2025-05-08 12:18:26.428901 | Pipeline: check 2025-05-08 12:18:26.428922 | Executor: 7d211f194f6a 2025-05-08 12:18:26.428941 | Triggered by: https://github.com/osism/testbed/pull/2672 2025-05-08 12:18:26.428960 | Event ID: 829bcd40-2c06-11f0-8f23-8f863f26f043 2025-05-08 12:18:26.437641 | 2025-05-08 12:18:26.437764 | LOOP [emit-job-header : Print node information] 2025-05-08 12:18:26.605532 | ubuntu-noble | ok: 2025-05-08 12:18:26.605759 | ubuntu-noble | # Node Information 2025-05-08 12:18:26.605917 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-08 12:18:26.605956 | ubuntu-noble | Hostname: ubuntu 2025-05-08 12:18:26.605980 | ubuntu-noble | Username: zuul 2025-05-08 12:18:26.606000 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-08 12:18:26.606024 | ubuntu-noble | Provider: regiocloud-a 2025-05-08 12:18:26.606044 | ubuntu-noble | Region: 2025-05-08 12:18:26.606065 | ubuntu-noble | Label: ubuntu-noble 2025-05-08 12:18:26.606084 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-08 12:18:26.606104 | ubuntu-noble | Interface IP: 81.163.193.152 2025-05-08 12:18:26.639051 | 2025-05-08 12:18:26.639211 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-08 12:18:27.179433 | ubuntu-noble -> localhost | changed 2025-05-08 12:18:27.188138 | 2025-05-08 12:18:27.188280 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-08 12:18:28.273432 | ubuntu-noble -> localhost | changed 2025-05-08 12:18:28.290920 | 2025-05-08 12:18:28.291109 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-08 12:18:28.622566 | ubuntu-noble -> localhost | ok 2025-05-08 12:18:28.630228 | 2025-05-08 12:18:28.630370 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-08 12:18:28.661305 | ubuntu-noble | ok 2025-05-08 12:18:28.678128 | ubuntu-noble | included: /var/lib/zuul/builds/9f49fb27d2764b428f15acbca7f29aa1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-08 12:18:28.686021 | 2025-05-08 12:18:28.686134 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-08 12:18:29.352004 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-08 12:18:29.352247 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9f49fb27d2764b428f15acbca7f29aa1/work/9f49fb27d2764b428f15acbca7f29aa1_id_rsa 2025-05-08 12:18:29.352286 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9f49fb27d2764b428f15acbca7f29aa1/work/9f49fb27d2764b428f15acbca7f29aa1_id_rsa.pub 2025-05-08 12:18:29.352312 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-08 12:18:29.352336 | ubuntu-noble -> localhost | SHA256:/S+lwx7yy9zeA6PYyvNcDYEb3RVvSb1MwAQk1F5Ju0o zuul-build-sshkey 2025-05-08 12:18:29.352358 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-08 12:18:29.352379 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-08 12:18:29.352400 | ubuntu-noble -> localhost | | .ooo=+oo+| 2025-05-08 12:18:29.352421 | ubuntu-noble -> localhost | | ..o++.=| 2025-05-08 12:18:29.352441 | ubuntu-noble -> localhost | | .o.+oo+| 2025-05-08 12:18:29.352473 | ubuntu-noble -> localhost | | . .o o+ | 2025-05-08 12:18:29.352515 | ubuntu-noble -> localhost | | S .E o | 2025-05-08 12:18:29.352547 | ubuntu-noble -> localhost | | ...o+ | 2025-05-08 12:18:29.352569 | ubuntu-noble -> localhost | | +o++o. | 2025-05-08 12:18:29.352590 | ubuntu-noble -> localhost | | .o.B*+ o | 2025-05-08 12:18:29.352611 | ubuntu-noble -> localhost | | o++*=+ o| 2025-05-08 12:18:29.352632 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-08 12:18:29.352689 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.141728 2025-05-08 12:18:29.362280 | 2025-05-08 12:18:29.362400 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-08 12:18:29.392872 | ubuntu-noble | ok 2025-05-08 12:18:29.404192 | ubuntu-noble | included: /var/lib/zuul/builds/9f49fb27d2764b428f15acbca7f29aa1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-08 12:18:29.413994 | 2025-05-08 12:18:29.414094 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-08 12:18:29.438120 | ubuntu-noble | skipping: Conditional result was False 2025-05-08 12:18:29.445438 | 2025-05-08 12:18:29.445566 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-08 12:18:30.165971 | ubuntu-noble | changed 2025-05-08 12:18:30.174763 | 2025-05-08 12:18:30.174910 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-08 12:18:30.491169 | ubuntu-noble | ok 2025-05-08 12:18:30.502142 | 2025-05-08 12:18:30.502297 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-08 12:18:31.223921 | ubuntu-noble | changed 2025-05-08 12:18:31.234465 | 2025-05-08 12:18:31.234615 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-08 12:18:31.945521 | ubuntu-noble | changed 2025-05-08 12:18:31.955971 | 2025-05-08 12:18:31.956110 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-08 12:18:31.991770 | ubuntu-noble | skipping: Conditional result was False 2025-05-08 12:18:32.009379 | 2025-05-08 12:18:32.009596 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-08 12:18:32.482005 | ubuntu-noble -> localhost | changed 2025-05-08 12:18:32.511360 | 2025-05-08 12:18:32.511575 | TASK [add-build-sshkey : Add back temp key] 2025-05-08 12:18:32.906798 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9f49fb27d2764b428f15acbca7f29aa1/work/9f49fb27d2764b428f15acbca7f29aa1_id_rsa (zuul-build-sshkey) 2025-05-08 12:18:32.907089 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014953 2025-05-08 12:18:32.915147 | 2025-05-08 12:18:32.915287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-08 12:18:33.451268 | ubuntu-noble | ok 2025-05-08 12:18:33.458080 | 2025-05-08 12:18:33.458204 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-08 12:18:33.482648 | ubuntu-noble | skipping: Conditional result was False 2025-05-08 12:18:33.498043 | 2025-05-08 12:18:33.498181 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-08 12:18:34.009683 | ubuntu-noble | ok 2025-05-08 12:18:34.022227 | 2025-05-08 12:18:34.022352 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-08 12:18:34.072294 | ubuntu-noble | ok 2025-05-08 12:18:34.081440 | 2025-05-08 12:18:34.081629 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-08 12:18:34.382540 | ubuntu-noble -> localhost | ok 2025-05-08 12:18:34.395711 | 2025-05-08 12:18:34.395894 | TASK [validate-host : Collect information about the host] 2025-05-08 12:18:35.607089 | ubuntu-noble | ok 2025-05-08 12:18:35.630008 | 2025-05-08 12:18:35.630173 | TASK [validate-host : Sanitize hostname] 2025-05-08 12:18:35.711974 | ubuntu-noble | ok 2025-05-08 12:18:35.720051 | 2025-05-08 12:18:35.720184 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-08 12:18:36.289404 | ubuntu-noble -> localhost | changed 2025-05-08 12:18:36.304157 | 2025-05-08 12:18:36.304327 | TASK [validate-host : Collect information about zuul worker] 2025-05-08 12:18:36.779747 | ubuntu-noble | ok 2025-05-08 12:18:36.787135 | 2025-05-08 12:18:36.787277 | TASK [validate-host : Write out all zuul information for each host] 2025-05-08 12:18:37.371463 | ubuntu-noble -> localhost | changed 2025-05-08 12:18:37.389357 | 2025-05-08 12:18:37.389553 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-08 12:18:37.699932 | ubuntu-noble | ok 2025-05-08 12:18:37.711257 | 2025-05-08 12:18:37.711419 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-08 12:18:38.839279 | ubuntu-noble | changed: 2025-05-08 12:18:38.839589 | ubuntu-noble | cd+++++++++ src/ 2025-05-08 12:18:38.839629 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-08 12:18:38.839652 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-08 12:18:38.839673 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-05-08 12:18:38.839693 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005065 2025-05-08 12:19:10.812399 | 2025-05-08 12:19:10.812568 | TASK [upload-logs : Upload logs to log server] 2025-05-08 12:19:11.417301 | localhost | Output suppressed because no_log was given 2025-05-08 12:19:11.420662 | 2025-05-08 12:19:11.420779 | LOOP [upload-logs : Compress console log and json output] 2025-05-08 12:19:11.481890 | localhost | skipping: Conditional result was False 2025-05-08 12:19:11.501642 | localhost | skipping: Conditional result was False 2025-05-08 12:19:11.518123 | 2025-05-08 12:19:11.518360 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-08 12:19:11.583939 | localhost | skipping: Conditional result was False 2025-05-08 12:19:11.584231 | 2025-05-08 12:19:11.599602 | localhost | skipping: Conditional result was False 2025-05-08 12:19:11.609390 | 2025-05-08 12:19:11.609558 | LOOP [upload-logs : Upload console log and json output]