2025-01-28 22:10:27.338501 | Job console starting... 2025-01-28 22:10:27.360269 | Updating repositories 2025-01-28 22:10:27.430689 | Preparing job workspace 2025-01-28 22:10:29.326585 | Running Ansible setup... 2025-01-28 22:10:35.345877 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-28 22:10:36.154899 | 2025-01-28 22:10:36.155089 | PLAY [Base pre] 2025-01-28 22:10:36.204066 | 2025-01-28 22:10:36.204222 | TASK [Setup log path fact] 2025-01-28 22:10:36.236656 | ubuntu-noble | ok 2025-01-28 22:10:36.260894 | 2025-01-28 22:10:36.261055 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-28 22:10:36.310064 | ubuntu-noble | ok 2025-01-28 22:10:36.319419 | 2025-01-28 22:10:36.319525 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-28 22:10:36.394658 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:36.402122 | 2025-01-28 22:10:36.402248 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-28 22:10:36.483972 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:36.492192 | 2025-01-28 22:10:36.492301 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-28 22:10:36.516736 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:36.523746 | 2025-01-28 22:10:36.523843 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-28 22:10:36.577197 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:36.584670 | 2025-01-28 22:10:36.584789 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-28 22:10:36.633108 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:36.651837 | 2025-01-28 22:10:36.651955 | TASK [emit-job-header : Print job information] 2025-01-28 22:10:36.740792 | # Job Information 2025-01-28 22:10:36.740967 | Ansible Version: 2.15.3 2025-01-28 22:10:36.740998 | Job: flake8 2025-01-28 22:10:36.741051 | Pipeline: check 2025-01-28 22:10:36.741071 | Executor: 7d211f194f6a 2025-01-28 22:10:36.741090 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1696 2025-01-28 22:10:36.741107 | Event ID: 9cce5810-ddc1-11ef-8bc9-1499198786a9 2025-01-28 22:10:36.747354 | 2025-01-28 22:10:36.747446 | LOOP [emit-job-header : Print node information] 2025-01-28 22:10:36.891413 | ubuntu-noble | ok: 2025-01-28 22:10:36.891653 | ubuntu-noble | # Node Information 2025-01-28 22:10:36.891691 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-28 22:10:36.891716 | ubuntu-noble | Hostname: ubuntu 2025-01-28 22:10:36.891739 | ubuntu-noble | Username: zuul 2025-01-28 22:10:36.891761 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-28 22:10:36.891781 | ubuntu-noble | Provider: regiocloud-a 2025-01-28 22:10:36.891801 | ubuntu-noble | Label: ubuntu-noble 2025-01-28 22:10:36.891821 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-28 22:10:36.891841 | ubuntu-noble | Interface IP: 81.163.193.135 2025-01-28 22:10:36.909807 | 2025-01-28 22:10:36.909928 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-28 22:10:37.399476 | ubuntu-noble -> localhost | changed 2025-01-28 22:10:37.406521 | 2025-01-28 22:10:37.406617 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-28 22:10:38.606648 | ubuntu-noble -> localhost | changed 2025-01-28 22:10:38.628952 | 2025-01-28 22:10:38.629102 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-28 22:10:39.018859 | ubuntu-noble -> localhost | ok 2025-01-28 22:10:39.027349 | 2025-01-28 22:10:39.027459 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-28 22:10:39.059152 | ubuntu-noble | ok 2025-01-28 22:10:39.081660 | ubuntu-noble | included: /var/lib/zuul/builds/f621f2187047485993202c9714616f95/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-28 22:10:39.089329 | 2025-01-28 22:10:39.089424 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-28 22:10:39.799951 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-28 22:10:39.800202 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f621f2187047485993202c9714616f95/work/f621f2187047485993202c9714616f95_id_rsa 2025-01-28 22:10:39.800240 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f621f2187047485993202c9714616f95/work/f621f2187047485993202c9714616f95_id_rsa.pub 2025-01-28 22:10:39.800265 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-28 22:10:39.800288 | ubuntu-noble -> localhost | SHA256:FHE/V7BJhKJIJDu+nzmpkdIaUBXDz2Bbnq4s9Nz183Y zuul-build-sshkey 2025-01-28 22:10:39.800310 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-28 22:10:39.800335 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-28 22:10:39.800356 | ubuntu-noble -> localhost | | .=o. o.. o+..| 2025-01-28 22:10:39.800376 | ubuntu-noble -> localhost | | .++o o.... + | 2025-01-28 22:10:39.800418 | ubuntu-noble -> localhost | | ..oO o.. .o + | 2025-01-28 22:10:39.800439 | ubuntu-noble -> localhost | | . ...*.. o | 2025-01-28 22:10:39.800459 | ubuntu-noble -> localhost | |. .. S | 2025-01-28 22:10:39.800478 | ubuntu-noble -> localhost | | ... o. . | 2025-01-28 22:10:39.800497 | ubuntu-noble -> localhost | | .o+=o o . | 2025-01-28 22:10:39.800517 | ubuntu-noble -> localhost | | .+=o+o o . E | 2025-01-28 22:10:39.800536 | ubuntu-noble -> localhost | | ....+. +.. | 2025-01-28 22:10:39.800555 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-28 22:10:39.800603 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.221732 2025-01-28 22:10:39.808359 | 2025-01-28 22:10:39.808492 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-28 22:10:39.873658 | ubuntu-noble | ok 2025-01-28 22:10:39.896720 | ubuntu-noble | included: /var/lib/zuul/builds/f621f2187047485993202c9714616f95/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-28 22:10:39.909271 | 2025-01-28 22:10:39.909353 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-28 22:10:39.933822 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:39.940101 | 2025-01-28 22:10:39.940183 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-28 22:10:40.612076 | ubuntu-noble | changed 2025-01-28 22:10:40.619891 | 2025-01-28 22:10:40.619996 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-28 22:10:40.872728 | ubuntu-noble | ok 2025-01-28 22:10:40.878314 | 2025-01-28 22:10:40.878394 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-28 22:10:41.510609 | ubuntu-noble | changed 2025-01-28 22:10:41.517852 | 2025-01-28 22:10:41.517940 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-28 22:10:42.131552 | ubuntu-noble | changed 2025-01-28 22:10:42.139439 | 2025-01-28 22:10:42.139538 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-28 22:10:42.163566 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:42.170653 | 2025-01-28 22:10:42.170738 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-28 22:10:42.591510 | ubuntu-noble -> localhost | changed 2025-01-28 22:10:42.607255 | 2025-01-28 22:10:42.607375 | TASK [add-build-sshkey : Add back temp key] 2025-01-28 22:10:43.184546 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f621f2187047485993202c9714616f95/work/f621f2187047485993202c9714616f95_id_rsa (zuul-build-sshkey) 2025-01-28 22:10:43.185108 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.024387 2025-01-28 22:10:43.192940 | 2025-01-28 22:10:43.193045 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-28 22:10:43.839818 | ubuntu-noble | ok 2025-01-28 22:10:43.849806 | 2025-01-28 22:10:43.849928 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-28 22:10:43.884739 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 22:10:43.898035 | 2025-01-28 22:10:43.898150 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-28 22:10:44.391149 | ubuntu-noble | ok 2025-01-28 22:10:44.405348 | 2025-01-28 22:10:44.405475 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-28 22:10:44.446171 | ubuntu-noble | ok 2025-01-28 22:10:44.452794 | 2025-01-28 22:10:44.452892 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-28 22:10:44.870085 | ubuntu-noble -> localhost | ok 2025-01-28 22:10:44.877771 | 2025-01-28 22:10:44.877873 | TASK [validate-host : Collect information about the host] 2025-01-28 22:10:46.036755 | ubuntu-noble | ok 2025-01-28 22:10:46.048903 | 2025-01-28 22:10:46.049007 | TASK [validate-host : Sanitize hostname] 2025-01-28 22:10:46.119235 | ubuntu-noble | ok 2025-01-28 22:10:46.125370 | 2025-01-28 22:10:46.125472 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-28 22:10:46.646549 | ubuntu-noble -> localhost | changed 2025-01-28 22:10:46.657066 | 2025-01-28 22:10:46.657186 | TASK [validate-host : Collect information about zuul worker] 2025-01-28 22:10:47.097423 | ubuntu-noble | ok 2025-01-28 22:10:47.108320 | 2025-01-28 22:10:47.108524 | TASK [validate-host : Write out all zuul information for each host] 2025-01-28 22:10:47.851268 | ubuntu-noble -> localhost | changed 2025-01-28 22:10:47.866698 | 2025-01-28 22:10:47.866805 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-28 22:10:48.150550 | ubuntu-noble | ok 2025-01-28 22:10:48.157313 | 2025-01-28 22:10:48.157408 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-28 22:10:49.339038 | ubuntu-noble | changed: 2025-01-28 22:10:49.339273 | ubuntu-noble | cd+++++++++ src/ 2025-01-28 22:10:49.339307 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-28 22:10:49.339332 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-28 22:10:49.339353 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-01-28 22:10:49.339373 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008180 2025-01-28 22:11:53.584155 | 2025-01-28 22:11:53.584304 | TASK [upload-logs : Upload logs to log server] 2025-01-28 22:11:54.200513 | localhost | Output suppressed because no_log was given 2025-01-28 22:11:54.205922 | 2025-01-28 22:11:54.206112 | LOOP [upload-logs : Compress console log and json output] 2025-01-28 22:11:54.290383 | localhost | skipping: Conditional result was False 2025-01-28 22:11:54.308155 | localhost | skipping: Conditional result was False 2025-01-28 22:11:54.325154 | 2025-01-28 22:11:54.325410 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-28 22:11:54.394254 | localhost | skipping: Conditional result was False 2025-01-28 22:11:54.394998 | 2025-01-28 22:11:54.406573 | localhost | skipping: Conditional result was False 2025-01-28 22:11:54.433077 | 2025-01-28 22:11:54.433281 | LOOP [upload-logs : Upload console log and json output]