2025-04-08 07:36:39.581634 | Job console starting... 2025-04-08 07:36:39.589117 | Updating repositories 2025-04-08 07:36:39.620134 | Preparing job workspace 2025-04-08 07:36:41.524943 | Running Ansible setup... 2025-04-08 07:36:46.955142 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-08 07:36:47.832356 | 2025-04-08 07:36:47.832545 | PLAY [Base pre] 2025-04-08 07:36:47.867013 | 2025-04-08 07:36:47.867165 | TASK [Setup log path fact] 2025-04-08 07:36:47.898969 | ubuntu-noble | ok 2025-04-08 07:36:47.919347 | 2025-04-08 07:36:47.919504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-08 07:36:47.971925 | ubuntu-noble | ok 2025-04-08 07:36:47.996056 | 2025-04-08 07:36:47.996193 | TASK [emit-job-header : Print job information] 2025-04-08 07:36:48.047989 | # Job Information 2025-04-08 07:36:48.048178 | Ansible Version: 2.15.3 2025-04-08 07:36:48.048213 | Job: python-black 2025-04-08 07:36:48.048244 | Pipeline: check 2025-04-08 07:36:48.048265 | Executor: 7d211f194f6a 2025-04-08 07:36:48.048283 | Triggered by: https://github.com/osism/testbed/pull/2659 2025-04-08 07:36:48.048302 | Event ID: 30be8e30-144c-11f0-8c36-1f15ae69184f 2025-04-08 07:36:48.055136 | 2025-04-08 07:36:48.055255 | LOOP [emit-job-header : Print node information] 2025-04-08 07:36:48.244718 | ubuntu-noble | ok: 2025-04-08 07:36:48.244916 | ubuntu-noble | # Node Information 2025-04-08 07:36:48.244951 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-08 07:36:48.244975 | ubuntu-noble | Hostname: ubuntu 2025-04-08 07:36:48.244996 | ubuntu-noble | Username: zuul 2025-04-08 07:36:48.245016 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-08 07:36:48.245040 | ubuntu-noble | Provider: regiocloud-a 2025-04-08 07:36:48.245061 | ubuntu-noble | Label: ubuntu-noble 2025-04-08 07:36:48.245081 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-08 07:36:48.245101 | ubuntu-noble | Interface IP: 81.163.192.59 2025-04-08 07:36:48.264940 | 2025-04-08 07:36:48.265081 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-08 07:36:48.894210 | ubuntu-noble -> localhost | changed 2025-04-08 07:36:48.904231 | 2025-04-08 07:36:48.904577 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-08 07:36:49.920700 | ubuntu-noble -> localhost | changed 2025-04-08 07:36:49.935503 | 2025-04-08 07:36:49.935608 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-08 07:36:50.233177 | ubuntu-noble -> localhost | ok 2025-04-08 07:36:50.240378 | 2025-04-08 07:36:50.240503 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-08 07:36:50.298494 | ubuntu-noble | ok 2025-04-08 07:36:50.319102 | ubuntu-noble | included: /var/lib/zuul/builds/092f18ba74c24f8ba73d664054052e9c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-08 07:36:50.325482 | 2025-04-08 07:36:50.325557 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-08 07:36:50.861773 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-08 07:36:50.861951 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/092f18ba74c24f8ba73d664054052e9c/work/092f18ba74c24f8ba73d664054052e9c_id_rsa 2025-04-08 07:36:50.861986 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/092f18ba74c24f8ba73d664054052e9c/work/092f18ba74c24f8ba73d664054052e9c_id_rsa.pub 2025-04-08 07:36:50.862011 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-08 07:36:50.862034 | ubuntu-noble -> localhost | SHA256:ADIKI7VFKBNcO2ZyWYjGhF0YmRhwv5JJUXc4QYWVJ28 zuul-build-sshkey 2025-04-08 07:36:50.862055 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-08 07:36:50.862075 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-08 07:36:50.862095 | ubuntu-noble -> localhost | |&BX@Bo+*+. | 2025-04-08 07:36:50.862116 | ubuntu-noble -> localhost | |BO*O+o+.o . | 2025-04-08 07:36:50.862135 | ubuntu-noble -> localhost | |o+oB. .. + | 2025-04-08 07:36:50.862163 | ubuntu-noble -> localhost | | .=o.. . E | 2025-04-08 07:36:50.862184 | ubuntu-noble -> localhost | | + . S. | 2025-04-08 07:36:50.862204 | ubuntu-noble -> localhost | | . | 2025-04-08 07:36:50.862225 | ubuntu-noble -> localhost | | | 2025-04-08 07:36:50.862245 | ubuntu-noble -> localhost | | | 2025-04-08 07:36:50.862265 | ubuntu-noble -> localhost | | | 2025-04-08 07:36:50.862285 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-08 07:36:50.862348 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.128436 2025-04-08 07:36:50.871092 | 2025-04-08 07:36:50.871189 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-08 07:36:50.891517 | ubuntu-noble | ok 2025-04-08 07:36:50.902700 | ubuntu-noble | included: /var/lib/zuul/builds/092f18ba74c24f8ba73d664054052e9c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-08 07:36:50.912712 | 2025-04-08 07:36:50.912798 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-08 07:36:50.936561 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 07:36:50.943800 | 2025-04-08 07:36:50.943896 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-08 07:36:51.662101 | ubuntu-noble | changed 2025-04-08 07:36:51.668924 | 2025-04-08 07:36:51.669011 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-08 07:36:51.992253 | ubuntu-noble | ok 2025-04-08 07:36:52.002174 | 2025-04-08 07:36:52.002281 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-08 07:36:52.766421 | ubuntu-noble | changed 2025-04-08 07:36:52.781399 | 2025-04-08 07:36:52.781560 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-08 07:36:53.525402 | ubuntu-noble | changed 2025-04-08 07:36:53.536774 | 2025-04-08 07:36:53.536878 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-08 07:36:53.561974 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 07:36:53.572827 | 2025-04-08 07:36:53.572918 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-08 07:36:54.024358 | ubuntu-noble -> localhost | changed 2025-04-08 07:36:54.042217 | 2025-04-08 07:36:54.042320 | TASK [add-build-sshkey : Add back temp key] 2025-04-08 07:36:54.355482 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/092f18ba74c24f8ba73d664054052e9c/work/092f18ba74c24f8ba73d664054052e9c_id_rsa (zuul-build-sshkey) 2025-04-08 07:36:54.355666 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013013 2025-04-08 07:36:54.361703 | 2025-04-08 07:36:54.361783 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-08 07:36:54.766800 | ubuntu-noble | ok 2025-04-08 07:36:54.776719 | 2025-04-08 07:36:54.776835 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-08 07:36:54.821951 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 07:36:54.844055 | 2025-04-08 07:36:54.844164 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-08 07:36:55.321740 | ubuntu-noble | ok 2025-04-08 07:36:55.333487 | 2025-04-08 07:36:55.333585 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-08 07:36:55.373447 | ubuntu-noble | ok 2025-04-08 07:36:55.379670 | 2025-04-08 07:36:55.379770 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-08 07:36:55.606822 | ubuntu-noble -> localhost | ok 2025-04-08 07:36:55.613286 | 2025-04-08 07:36:55.613385 | TASK [validate-host : Collect information about the host] 2025-04-08 07:36:56.782348 | ubuntu-noble | ok 2025-04-08 07:36:56.803416 | 2025-04-08 07:36:56.803516 | TASK [validate-host : Sanitize hostname] 2025-04-08 07:36:56.872998 | ubuntu-noble | ok 2025-04-08 07:36:56.880974 | 2025-04-08 07:36:56.881074 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-08 07:36:57.428653 | ubuntu-noble -> localhost | changed 2025-04-08 07:36:57.435437 | 2025-04-08 07:36:57.435539 | TASK [validate-host : Collect information about zuul worker] 2025-04-08 07:36:58.037629 | ubuntu-noble | ok 2025-04-08 07:36:58.043738 | 2025-04-08 07:36:58.043821 | TASK [validate-host : Write out all zuul information for each host] 2025-04-08 07:36:58.630906 | ubuntu-noble -> localhost | changed 2025-04-08 07:36:58.642591 | 2025-04-08 07:36:58.642685 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-08 07:36:59.010041 | ubuntu-noble | ok 2025-04-08 07:36:59.021260 | 2025-04-08 07:36:59.021379 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-08 07:37:00.631134 | ubuntu-noble | changed: 2025-04-08 07:37:00.631299 | ubuntu-noble | cd+++++++++ src/ 2025-04-08 07:37:00.631364 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-08 07:37:00.631391 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-08 07:37:00.631412 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-08 07:37:00.631432 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005774 2025-04-08 07:37:36.838969 | 2025-04-08 07:37:36.839253 | TASK [upload-logs : Upload logs to log server] 2025-04-08 07:37:37.522943 | localhost | Output suppressed because no_log was given 2025-04-08 07:37:37.529531 | 2025-04-08 07:37:37.529707 | LOOP [upload-logs : Compress console log and json output] 2025-04-08 07:37:37.604548 | localhost | skipping: Conditional result was False 2025-04-08 07:37:37.626773 | localhost | skipping: Conditional result was False 2025-04-08 07:37:37.632298 | 2025-04-08 07:37:37.632452 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-08 07:37:37.696480 | localhost | skipping: Conditional result was False 2025-04-08 07:37:37.696821 | 2025-04-08 07:37:37.709938 | localhost | skipping: Conditional result was False 2025-04-08 07:37:37.727586 | 2025-04-08 07:37:37.727752 | LOOP [upload-logs : Upload console log and json output]