2025-09-29 21:37:33.288790 | Job console starting 2025-09-29 21:37:33.307903 | Updating git repos 2025-09-29 21:37:33.342065 | Cloning repos into workspace 2025-09-29 21:37:33.378474 | Restoring repo states 2025-09-29 21:37:33.382855 | Merging changes 2025-09-29 21:37:33.932661 | Checking out repos 2025-09-29 21:37:34.033414 | Preparing playbooks 2025-09-29 21:37:34.543186 | Running Ansible setup 2025-09-29 21:37:38.684451 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-09-29 21:37:39.439524 | 2025-09-29 21:37:39.439673 | PLAY [Base pre] 2025-09-29 21:37:39.455918 | 2025-09-29 21:37:39.456038 | TASK [Setup log path fact] 2025-09-29 21:37:39.474511 | ubuntu-jammy | ok 2025-09-29 21:37:39.488942 | 2025-09-29 21:37:39.489067 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-29 21:37:39.519148 | ubuntu-jammy | ok 2025-09-29 21:37:39.529976 | 2025-09-29 21:37:39.530085 | TASK [emit-job-header : Print job information] 2025-09-29 21:37:39.603642 | # Job Information 2025-09-29 21:37:39.603904 | Ansible Version: 2.16.14 2025-09-29 21:37:39.603966 | Job: python-black 2025-09-29 21:37:39.604023 | Pipeline: check 2025-09-29 21:37:39.604062 | Executor: 521e9411259a 2025-09-29 21:37:39.604098 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/289 2025-09-29 21:37:39.604137 | Event ID: 66ce5870-9d7c-11f0-92d5-15a51c33740b 2025-09-29 21:37:39.612950 | 2025-09-29 21:37:39.613092 | LOOP [emit-job-header : Print node information] 2025-09-29 21:37:39.720477 | ubuntu-jammy | ok: 2025-09-29 21:37:39.720679 | ubuntu-jammy | # Node Information 2025-09-29 21:37:39.720716 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-09-29 21:37:39.720741 | ubuntu-jammy | Hostname: ubuntu 2025-09-29 21:37:39.720764 | ubuntu-jammy | Username: zuul 2025-09-29 21:37:39.720785 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-09-29 21:37:39.720809 | ubuntu-jammy | Provider: regiocloud-a 2025-09-29 21:37:39.720831 | ubuntu-jammy | Region: 2025-09-29 21:37:39.720852 | ubuntu-jammy | Label: ubuntu-jammy 2025-09-29 21:37:39.720872 | ubuntu-jammy | Product Name: OpenStack Nova 2025-09-29 21:37:39.720892 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:7108 2025-09-29 21:37:39.743130 | 2025-09-29 21:37:39.743283 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-29 21:37:40.243451 | ubuntu-jammy -> localhost | changed 2025-09-29 21:37:40.259564 | 2025-09-29 21:37:40.259742 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-29 21:37:41.316737 | ubuntu-jammy -> localhost | changed 2025-09-29 21:37:41.329077 | 2025-09-29 21:37:41.329199 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-29 21:37:41.573107 | ubuntu-jammy -> localhost | ok 2025-09-29 21:37:41.585907 | 2025-09-29 21:37:41.586082 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-29 21:37:41.607633 | ubuntu-jammy | ok 2025-09-29 21:37:41.627567 | ubuntu-jammy | included: /var/lib/zuul/builds/f70589a5d56f42f09b69ed22501967a7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-29 21:37:41.633490 | 2025-09-29 21:37:41.633585 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-29 21:37:43.443670 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-09-29 21:37:43.443891 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/f70589a5d56f42f09b69ed22501967a7/work/f70589a5d56f42f09b69ed22501967a7_id_rsa 2025-09-29 21:37:43.443930 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/f70589a5d56f42f09b69ed22501967a7/work/f70589a5d56f42f09b69ed22501967a7_id_rsa.pub 2025-09-29 21:37:43.443956 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-09-29 21:37:43.443979 | ubuntu-jammy -> localhost | SHA256:Q2eZkUo0qNY0mNVgk7Dj3pXS3lVFIqKNGW4Azn+HUDQ zuul-build-sshkey 2025-09-29 21:37:43.444002 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-09-29 21:37:43.444037 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-09-29 21:37:43.444059 | ubuntu-jammy -> localhost | | o**BE o.. ..o| 2025-09-29 21:37:43.444081 | ubuntu-jammy -> localhost | | ooo==oO.= . o | 2025-09-29 21:37:43.444101 | ubuntu-jammy -> localhost | | =+.oB.* . | 2025-09-29 21:37:43.444121 | ubuntu-jammy -> localhost | | .oo.=.= . | 2025-09-29 21:37:43.444140 | ubuntu-jammy -> localhost | | .. o S . . | 2025-09-29 21:37:43.444168 | ubuntu-jammy -> localhost | | . . = + . | 2025-09-29 21:37:43.444189 | ubuntu-jammy -> localhost | | . . . . | 2025-09-29 21:37:43.444208 | ubuntu-jammy -> localhost | | | 2025-09-29 21:37:43.444229 | ubuntu-jammy -> localhost | | | 2025-09-29 21:37:43.444250 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-09-29 21:37:43.444305 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:01.345038 2025-09-29 21:37:43.450913 | 2025-09-29 21:37:43.451027 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-29 21:37:43.469974 | ubuntu-jammy | ok 2025-09-29 21:37:43.480885 | ubuntu-jammy | included: /var/lib/zuul/builds/f70589a5d56f42f09b69ed22501967a7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-29 21:37:43.489764 | 2025-09-29 21:37:43.489864 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-29 21:37:43.503029 | ubuntu-jammy | skipping: Conditional result was False 2025-09-29 21:37:43.509649 | 2025-09-29 21:37:43.509771 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-29 21:37:44.091943 | ubuntu-jammy | changed 2025-09-29 21:37:44.100873 | 2025-09-29 21:37:44.101042 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-29 21:37:44.340143 | ubuntu-jammy | ok 2025-09-29 21:37:44.348097 | 2025-09-29 21:37:44.348240 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-29 21:37:45.022063 | ubuntu-jammy | changed 2025-09-29 21:37:45.031984 | 2025-09-29 21:37:45.032113 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-29 21:37:45.604679 | ubuntu-jammy | changed 2025-09-29 21:37:45.610392 | 2025-09-29 21:37:45.610503 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-29 21:37:45.624608 | ubuntu-jammy | skipping: Conditional result was False 2025-09-29 21:37:45.630595 | 2025-09-29 21:37:45.630699 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-29 21:37:46.060401 | ubuntu-jammy -> localhost | changed 2025-09-29 21:37:46.071373 | 2025-09-29 21:37:46.071494 | TASK [add-build-sshkey : Add back temp key] 2025-09-29 21:37:46.400997 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/f70589a5d56f42f09b69ed22501967a7/work/f70589a5d56f42f09b69ed22501967a7_id_rsa (zuul-build-sshkey) 2025-09-29 21:37:46.401242 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.016461 2025-09-29 21:37:46.409298 | 2025-09-29 21:37:46.409432 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-29 21:37:46.811566 | ubuntu-jammy | ok 2025-09-29 21:37:46.816748 | 2025-09-29 21:37:46.816853 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-29 21:37:46.850355 | ubuntu-jammy | skipping: Conditional result was False 2025-09-29 21:37:46.860711 | 2025-09-29 21:37:46.860822 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-29 21:37:47.303377 | ubuntu-jammy | ok 2025-09-29 21:37:47.314133 | 2025-09-29 21:37:47.314251 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-29 21:37:47.364842 | ubuntu-jammy | ok 2025-09-29 21:37:47.369843 | 2025-09-29 21:37:47.369947 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-29 21:37:47.656689 | ubuntu-jammy -> localhost | ok 2025-09-29 21:37:47.663166 | 2025-09-29 21:37:47.663271 | TASK [validate-host : Collect information about the host] 2025-09-29 21:37:48.827099 | ubuntu-jammy | ok 2025-09-29 21:37:48.840439 | 2025-09-29 21:37:48.840574 | TASK [validate-host : Sanitize hostname] 2025-09-29 21:37:48.940875 | ubuntu-jammy | ok 2025-09-29 21:37:48.977175 | 2025-09-29 21:37:48.977300 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-29 21:37:49.602904 | ubuntu-jammy -> localhost | changed 2025-09-29 21:37:49.608953 | 2025-09-29 21:37:49.609067 | TASK [validate-host : Collect information about zuul worker] 2025-09-29 21:37:50.000793 | ubuntu-jammy | ok 2025-09-29 21:37:50.005748 | 2025-09-29 21:37:50.005865 | TASK [validate-host : Write out all zuul information for each host] 2025-09-29 21:37:50.628441 | ubuntu-jammy -> localhost | changed 2025-09-29 21:37:50.643125 | 2025-09-29 21:37:50.643261 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-29 21:37:50.933645 | ubuntu-jammy | ok 2025-09-29 21:37:50.950040 | 2025-09-29 21:37:50.950263 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-29 21:37:51.902872 | ubuntu-jammy | changed: 2025-09-29 21:37:51.903228 | ubuntu-jammy | cd+++++++++ src/ 2025-09-29 21:37:51.903293 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-09-29 21:37:51.903334 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-09-29 21:37:51.903392 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-09-29 21:37:51.903426 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.903672 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.926785 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.926871 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.926942 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.927012 | ubuntu-jammy | Containerfile 2025-09-29 21:37:51.927087 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.007242 2025-09-29 21:38:19.956286 | 2025-09-29 21:38:19.956432 | TASK [upload-logs : Upload logs to log server] 2025-09-29 21:38:20.512205 | localhost | Output suppressed because no_log was given 2025-09-29 21:38:20.514684 | 2025-09-29 21:38:20.514816 | LOOP [upload-logs : Compress console log and json output] 2025-09-29 21:38:20.565687 | localhost | skipping: Conditional result was False 2025-09-29 21:38:20.573472 | localhost | skipping: Conditional result was False 2025-09-29 21:38:20.585527 | 2025-09-29 21:38:20.585757 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-29 21:38:20.629609 | localhost | skipping: Conditional result was False 2025-09-29 21:38:20.629907 | 2025-09-29 21:38:20.636455 | localhost | skipping: Conditional result was False 2025-09-29 21:38:20.647862 | 2025-09-29 21:38:20.648092 | LOOP [upload-logs : Upload console log and json output]