2025-10-15 12:21:29.818226 | Job console starting 2025-10-15 12:21:29.837471 | Updating git repos 2025-10-15 12:21:29.871648 | Cloning repos into workspace 2025-10-15 12:21:29.918150 | Restoring repo states 2025-10-15 12:21:29.924720 | Merging changes 2025-10-15 12:21:30.509926 | Checking out repos 2025-10-15 12:21:30.560761 | Preparing playbooks 2025-10-15 12:21:31.043787 | Running Ansible setup 2025-10-15 12:21:35.355883 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-10-15 12:21:36.187427 | 2025-10-15 12:21:36.187585 | PLAY [Base pre] 2025-10-15 12:21:36.203735 | 2025-10-15 12:21:36.203865 | TASK [Setup log path fact] 2025-10-15 12:21:36.252458 | ubuntu-jammy | ok 2025-10-15 12:21:36.272240 | 2025-10-15 12:21:36.272393 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 12:21:36.315071 | ubuntu-jammy | ok 2025-10-15 12:21:36.328136 | 2025-10-15 12:21:36.328259 | TASK [emit-job-header : Print job information] 2025-10-15 12:21:36.381242 | # Job Information 2025-10-15 12:21:36.381442 | Ansible Version: 2.16.14 2025-10-15 12:21:36.381481 | Job: python-black 2025-10-15 12:21:36.381527 | Pipeline: check 2025-10-15 12:21:36.381563 | Executor: 521e9411259a 2025-10-15 12:21:36.381591 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/302 2025-10-15 12:21:36.381615 | Event ID: 5a0821b0-a9c1-11f0-8e7e-e732a2b8421e 2025-10-15 12:21:36.389096 | 2025-10-15 12:21:36.389478 | LOOP [emit-job-header : Print node information] 2025-10-15 12:21:36.531660 | ubuntu-jammy | ok: 2025-10-15 12:21:36.533651 | ubuntu-jammy | # Node Information 2025-10-15 12:21:36.533768 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-10-15 12:21:36.533802 | ubuntu-jammy | Hostname: ubuntu 2025-10-15 12:21:36.533878 | ubuntu-jammy | Username: zuul 2025-10-15 12:21:36.533903 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-10-15 12:21:36.533928 | ubuntu-jammy | Provider: regiocloud-a 2025-10-15 12:21:36.533950 | ubuntu-jammy | Region: 2025-10-15 12:21:36.533971 | ubuntu-jammy | Label: ubuntu-jammy 2025-10-15 12:21:36.533991 | ubuntu-jammy | Product Name: OpenStack Nova 2025-10-15 12:21:36.534011 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:a16b 2025-10-15 12:21:36.557420 | 2025-10-15 12:21:36.557684 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-15 12:21:37.143008 | ubuntu-jammy -> localhost | changed 2025-10-15 12:21:37.150664 | 2025-10-15 12:21:37.150817 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-15 12:21:38.226267 | ubuntu-jammy -> localhost | changed 2025-10-15 12:21:38.247902 | 2025-10-15 12:21:38.248032 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-15 12:21:38.659731 | ubuntu-jammy -> localhost | ok 2025-10-15 12:21:38.666310 | 2025-10-15 12:21:38.666427 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-15 12:21:38.695050 | ubuntu-jammy | ok 2025-10-15 12:21:38.712131 | ubuntu-jammy | included: /var/lib/zuul/builds/d306df758b7e4950a37ddd5f75af11ff/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-15 12:21:38.718131 | 2025-10-15 12:21:38.718229 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-15 12:21:41.247478 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-10-15 12:21:41.247748 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/d306df758b7e4950a37ddd5f75af11ff/work/d306df758b7e4950a37ddd5f75af11ff_id_rsa 2025-10-15 12:21:41.247793 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/d306df758b7e4950a37ddd5f75af11ff/work/d306df758b7e4950a37ddd5f75af11ff_id_rsa.pub 2025-10-15 12:21:41.247821 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-10-15 12:21:41.247848 | ubuntu-jammy -> localhost | SHA256:UiNE9dltVzZ7Qo9nRSM35p0iWpTvwnLtKTamre0UAqg zuul-build-sshkey 2025-10-15 12:21:41.247871 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-10-15 12:21:41.247907 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-10-15 12:21:41.247930 | ubuntu-jammy -> localhost | | .o.. ....B=| 2025-10-15 12:21:41.247952 | ubuntu-jammy -> localhost | | .. ..+ o=+X| 2025-10-15 12:21:41.247972 | ubuntu-jammy -> localhost | | ...o ooo.=+B| 2025-10-15 12:21:41.247993 | ubuntu-jammy -> localhost | | . o..o .o.=.| 2025-10-15 12:21:41.248014 | ubuntu-jammy -> localhost | | E . So..o | 2025-10-15 12:21:41.248038 | ubuntu-jammy -> localhost | | . ..+.o | 2025-10-15 12:21:41.248058 | ubuntu-jammy -> localhost | | o.o . | 2025-10-15 12:21:41.248077 | ubuntu-jammy -> localhost | | += o | 2025-10-15 12:21:41.248098 | ubuntu-jammy -> localhost | | o*+o | 2025-10-15 12:21:41.248119 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-10-15 12:21:41.248174 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:02.016830 2025-10-15 12:21:41.255312 | 2025-10-15 12:21:41.255433 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-15 12:21:41.285960 | ubuntu-jammy | ok 2025-10-15 12:21:41.295760 | ubuntu-jammy | included: /var/lib/zuul/builds/d306df758b7e4950a37ddd5f75af11ff/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-15 12:21:41.305010 | 2025-10-15 12:21:41.305112 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-15 12:21:41.329709 | ubuntu-jammy | skipping: Conditional result was False 2025-10-15 12:21:41.339130 | 2025-10-15 12:21:41.339246 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-15 12:21:42.087219 | ubuntu-jammy | changed 2025-10-15 12:21:42.092951 | 2025-10-15 12:21:42.093061 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-15 12:21:42.366369 | ubuntu-jammy | ok 2025-10-15 12:21:42.374874 | 2025-10-15 12:21:42.375059 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-15 12:21:43.081153 | ubuntu-jammy | changed 2025-10-15 12:21:43.088121 | 2025-10-15 12:21:43.088232 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-15 12:21:43.685607 | ubuntu-jammy | changed 2025-10-15 12:21:43.691325 | 2025-10-15 12:21:43.691433 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-15 12:21:43.715140 | ubuntu-jammy | skipping: Conditional result was False 2025-10-15 12:21:43.721150 | 2025-10-15 12:21:43.721254 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-15 12:21:44.255307 | ubuntu-jammy -> localhost | changed 2025-10-15 12:21:44.267465 | 2025-10-15 12:21:44.267625 | TASK [add-build-sshkey : Add back temp key] 2025-10-15 12:21:44.671920 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/d306df758b7e4950a37ddd5f75af11ff/work/d306df758b7e4950a37ddd5f75af11ff_id_rsa (zuul-build-sshkey) 2025-10-15 12:21:44.672222 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.013969 2025-10-15 12:21:44.683886 | 2025-10-15 12:21:44.684027 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-15 12:21:45.109854 | ubuntu-jammy | ok 2025-10-15 12:21:45.116913 | 2025-10-15 12:21:45.117052 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-15 12:21:45.142952 | ubuntu-jammy | skipping: Conditional result was False 2025-10-15 12:21:45.153608 | 2025-10-15 12:21:45.153737 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-15 12:21:45.566803 | ubuntu-jammy | ok 2025-10-15 12:21:45.578082 | 2025-10-15 12:21:45.578198 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-15 12:21:45.606575 | ubuntu-jammy | ok 2025-10-15 12:21:45.611581 | 2025-10-15 12:21:45.611698 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-15 12:21:45.940685 | ubuntu-jammy -> localhost | ok 2025-10-15 12:21:45.950330 | 2025-10-15 12:21:45.950464 | TASK [validate-host : Collect information about the host] 2025-10-15 12:21:47.143580 | ubuntu-jammy | ok 2025-10-15 12:21:47.160483 | 2025-10-15 12:21:47.160615 | TASK [validate-host : Sanitize hostname] 2025-10-15 12:21:47.274871 | ubuntu-jammy | ok 2025-10-15 12:21:47.314040 | 2025-10-15 12:21:47.314164 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-15 12:21:47.910137 | ubuntu-jammy -> localhost | changed 2025-10-15 12:21:47.918696 | 2025-10-15 12:21:47.918854 | TASK [validate-host : Collect information about zuul worker] 2025-10-15 12:21:48.314258 | ubuntu-jammy | ok 2025-10-15 12:21:48.320062 | 2025-10-15 12:21:48.320189 | TASK [validate-host : Write out all zuul information for each host] 2025-10-15 12:21:48.893897 | ubuntu-jammy -> localhost | changed 2025-10-15 12:21:48.910481 | 2025-10-15 12:21:48.910613 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-15 12:21:49.177347 | ubuntu-jammy | ok 2025-10-15 12:21:49.186922 | 2025-10-15 12:21:49.187096 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-15 12:21:50.153259 | ubuntu-jammy | changed: 2025-10-15 12:21:50.153517 | ubuntu-jammy | cd+++++++++ src/ 2025-10-15 12:21:50.153560 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-10-15 12:21:50.153589 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-10-15 12:21:50.153740 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-10-15 12:21:50.153772 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.153952 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.179774 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.179844 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.179914 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.179982 | ubuntu-jammy | Containerfile 2025-10-15 12:21:50.180051 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.004354 2025-10-15 12:22:19.362861 | 2025-10-15 12:22:19.362966 | TASK [upload-logs : Upload logs to log server] 2025-10-15 12:22:19.898099 | localhost | Output suppressed because no_log was given 2025-10-15 12:22:19.901956 | 2025-10-15 12:22:19.902137 | LOOP [upload-logs : Compress console log and json output] 2025-10-15 12:22:19.958128 | localhost | skipping: Conditional result was False 2025-10-15 12:22:19.965944 | localhost | skipping: Conditional result was False 2025-10-15 12:22:19.972731 | 2025-10-15 12:22:19.972916 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-15 12:22:20.016796 | localhost | skipping: Conditional result was False 2025-10-15 12:22:20.017058 | 2025-10-15 12:22:20.023750 | localhost | skipping: Conditional result was False 2025-10-15 12:22:20.033757 | 2025-10-15 12:22:20.033993 | LOOP [upload-logs : Upload console log and json output]