2025-05-30 07:05:20.210543 | Job console starting 2025-05-30 07:05:20.223096 | Updating git repos 2025-05-30 07:05:20.274705 | Cloning repos into workspace 2025-05-30 07:05:20.335385 | Restoring repo states 2025-05-30 07:05:20.357558 | Merging changes 2025-05-30 07:05:20.934429 | Checking out repos 2025-05-30 07:05:21.010693 | Preparing playbooks 2025-05-30 07:05:21.661843 | Running Ansible setup 2025-05-30 07:05:25.948091 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 07:05:26.738588 | 2025-05-30 07:05:26.738760 | PLAY [Base pre] 2025-05-30 07:05:26.755104 | 2025-05-30 07:05:26.755248 | TASK [Setup log path fact] 2025-05-30 07:05:26.784683 | debian-bookworm | ok 2025-05-30 07:05:26.801174 | 2025-05-30 07:05:26.801367 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 07:05:26.842228 | debian-bookworm | ok 2025-05-30 07:05:26.852402 | 2025-05-30 07:05:26.852528 | TASK [emit-job-header : Print job information] 2025-05-30 07:05:26.912939 | # Job Information 2025-05-30 07:05:26.913288 | Ansible Version: 2.16.14 2025-05-30 07:05:26.913391 | Job: python-black 2025-05-30 07:05:26.913471 | Pipeline: check 2025-05-30 07:05:26.913524 | Executor: 521e9411259a 2025-05-30 07:05:26.913572 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1877 2025-05-30 07:05:26.913622 | Event ID: ebbb5d80-3d23-11f0-9833-10af0678365d 2025-05-30 07:05:26.923622 | 2025-05-30 07:05:26.923801 | LOOP [emit-job-header : Print node information] 2025-05-30 07:05:27.073225 | debian-bookworm | ok: 2025-05-30 07:05:27.073686 | debian-bookworm | # Node Information 2025-05-30 07:05:27.073772 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-30 07:05:27.073820 | debian-bookworm | Hostname: debian 2025-05-30 07:05:27.073861 | debian-bookworm | Username: zuul 2025-05-30 07:05:27.073900 | debian-bookworm | Distro: Debian 12.11 2025-05-30 07:05:27.073943 | debian-bookworm | Provider: regiocloud-a 2025-05-30 07:05:27.073980 | debian-bookworm | Region: 2025-05-30 07:05:27.074016 | debian-bookworm | Label: debian-bookworm 2025-05-30 07:05:27.074050 | debian-bookworm | Product Name: OpenStack Nova 2025-05-30 07:05:27.074084 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3d:4f4d 2025-05-30 07:05:27.100789 | 2025-05-30 07:05:27.100987 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 07:05:27.636654 | debian-bookworm -> localhost | changed 2025-05-30 07:05:27.653012 | 2025-05-30 07:05:27.653201 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 07:05:28.763115 | debian-bookworm -> localhost | changed 2025-05-30 07:05:28.774499 | 2025-05-30 07:05:28.774629 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 07:05:29.073882 | debian-bookworm -> localhost | ok 2025-05-30 07:05:29.088163 | 2025-05-30 07:05:29.088369 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 07:05:29.125087 | debian-bookworm | ok 2025-05-30 07:05:29.147677 | debian-bookworm | included: /var/lib/zuul/builds/d89932e19985495c9b28dbdb3abfd545/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 07:05:29.154285 | 2025-05-30 07:05:29.154509 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 07:05:31.774101 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-30 07:05:31.774599 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d89932e19985495c9b28dbdb3abfd545/work/d89932e19985495c9b28dbdb3abfd545_id_rsa 2025-05-30 07:05:31.774689 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d89932e19985495c9b28dbdb3abfd545/work/d89932e19985495c9b28dbdb3abfd545_id_rsa.pub 2025-05-30 07:05:31.774744 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-30 07:05:31.774792 | debian-bookworm -> localhost | SHA256:K7Lrn6CcxbD3MSeeMtje9ctyaKBS+zFqFX4JMjl0EI4 zuul-build-sshkey 2025-05-30 07:05:31.774872 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-30 07:05:31.774971 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-30 07:05:31.775048 | debian-bookworm -> localhost | | oo | 2025-05-30 07:05:31.775097 | debian-bookworm -> localhost | | o. . | 2025-05-30 07:05:31.775141 | debian-bookworm -> localhost | | E..o | 2025-05-30 07:05:31.775183 | debian-bookworm -> localhost | | = o | 2025-05-30 07:05:31.775225 | debian-bookworm -> localhost | | . = oS. | 2025-05-30 07:05:31.775279 | debian-bookworm -> localhost | | +. + o. | 2025-05-30 07:05:31.775344 | debian-bookworm -> localhost | | .+*+Bo+. | 2025-05-30 07:05:31.775389 | debian-bookworm -> localhost | | .o=BO %+o. | 2025-05-30 07:05:31.775435 | debian-bookworm -> localhost | | +=**O. o+. | 2025-05-30 07:05:31.775478 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-30 07:05:31.775632 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.081183 2025-05-30 07:05:31.786931 | 2025-05-30 07:05:31.787070 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 07:05:31.823521 | debian-bookworm | ok 2025-05-30 07:05:31.837212 | debian-bookworm | included: /var/lib/zuul/builds/d89932e19985495c9b28dbdb3abfd545/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 07:05:31.847007 | 2025-05-30 07:05:31.847124 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 07:05:31.873090 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:05:31.879375 | 2025-05-30 07:05:31.879486 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 07:05:32.558435 | debian-bookworm | changed 2025-05-30 07:05:32.567280 | 2025-05-30 07:05:32.567457 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 07:05:32.844530 | debian-bookworm | ok 2025-05-30 07:05:32.854444 | 2025-05-30 07:05:32.854612 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 07:05:33.599368 | debian-bookworm | changed 2025-05-30 07:05:33.609831 | 2025-05-30 07:05:33.609965 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 07:05:34.307283 | debian-bookworm | changed 2025-05-30 07:05:34.316662 | 2025-05-30 07:05:34.316806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 07:05:34.351239 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:05:34.365754 | 2025-05-30 07:05:34.365920 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 07:05:34.828668 | debian-bookworm -> localhost | changed 2025-05-30 07:05:34.850139 | 2025-05-30 07:05:34.850366 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 07:05:35.232654 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d89932e19985495c9b28dbdb3abfd545/work/d89932e19985495c9b28dbdb3abfd545_id_rsa (zuul-build-sshkey) 2025-05-30 07:05:35.233283 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019061 2025-05-30 07:05:35.249557 | 2025-05-30 07:05:35.249703 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 07:05:35.692767 | debian-bookworm | ok 2025-05-30 07:05:35.702719 | 2025-05-30 07:05:35.702930 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 07:05:35.738385 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:05:35.756586 | 2025-05-30 07:05:35.756722 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 07:05:36.215985 | debian-bookworm | ok 2025-05-30 07:05:36.228753 | 2025-05-30 07:05:36.228889 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 07:05:36.273566 | debian-bookworm | ok 2025-05-30 07:05:36.281402 | 2025-05-30 07:05:36.281525 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 07:05:36.602015 | debian-bookworm -> localhost | ok 2025-05-30 07:05:36.618513 | 2025-05-30 07:05:36.618669 | TASK [validate-host : Collect information about the host] 2025-05-30 07:05:37.768255 | debian-bookworm | ok 2025-05-30 07:05:37.797083 | 2025-05-30 07:05:37.798013 | TASK [validate-host : Sanitize hostname] 2025-05-30 07:05:37.940151 | debian-bookworm | ok 2025-05-30 07:05:37.985099 | 2025-05-30 07:05:37.985246 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 07:05:38.609744 | debian-bookworm -> localhost | changed 2025-05-30 07:05:38.623156 | 2025-05-30 07:05:38.623344 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 07:05:39.045611 | debian-bookworm | ok 2025-05-30 07:05:39.053803 | 2025-05-30 07:05:39.053987 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 07:05:39.645743 | debian-bookworm -> localhost | changed 2025-05-30 07:05:39.657751 | 2025-05-30 07:05:39.657864 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 07:05:39.935625 | debian-bookworm | ok 2025-05-30 07:05:39.946660 | 2025-05-30 07:05:39.946821 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 07:05:41.065753 | debian-bookworm | changed: 2025-05-30 07:05:41.066081 | debian-bookworm | cd+++++++++ src/ 2025-05-30 07:05:41.066122 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-30 07:05:41.066147 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-30 07:05:41.066168 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-30 07:05:41.066190 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006827 2025-05-30 07:06:07.513300 | 2025-05-30 07:06:07.513528 | TASK [upload-logs : Upload logs to log server] 2025-05-30 07:06:08.106396 | localhost | Output suppressed because no_log was given 2025-05-30 07:06:08.110286 | 2025-05-30 07:06:08.110537 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 07:06:08.164806 | localhost | skipping: Conditional result was False 2025-05-30 07:06:08.170047 | localhost | skipping: Conditional result was False 2025-05-30 07:06:08.183955 | 2025-05-30 07:06:08.184169 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 07:06:08.241532 | localhost | skipping: Conditional result was False 2025-05-30 07:06:08.241850 | 2025-05-30 07:06:08.256055 | localhost | skipping: Conditional result was False 2025-05-30 07:06:08.266620 | 2025-05-30 07:06:08.266778 | LOOP [upload-logs : Upload console log and json output]