2025-09-15 15:45:32.744513 | Job console starting 2025-09-15 15:45:32.755526 | Updating git repos 2025-09-15 15:45:32.781264 | Cloning repos into workspace 2025-09-15 15:45:32.814092 | Restoring repo states 2025-09-15 15:45:32.821467 | Merging changes 2025-09-15 15:45:33.390631 | Checking out repos 2025-09-15 15:45:33.417825 | Preparing playbooks 2025-09-15 15:45:33.927870 | Running Ansible setup 2025-09-15 15:45:38.195907 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-09-15 15:45:39.005268 | 2025-09-15 15:45:39.005474 | PLAY [Base pre] 2025-09-15 15:45:39.020998 | 2025-09-15 15:45:39.021161 | TASK [Setup log path fact] 2025-09-15 15:45:39.049798 | ubuntu-jammy | ok 2025-09-15 15:45:39.064474 | 2025-09-15 15:45:39.064603 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-15 15:45:39.094009 | ubuntu-jammy | ok 2025-09-15 15:45:39.103607 | 2025-09-15 15:45:39.103711 | TASK [emit-job-header : Print job information] 2025-09-15 15:45:39.143583 | # Job Information 2025-09-15 15:45:39.143779 | Ansible Version: 2.16.14 2025-09-15 15:45:39.143819 | Job: python-black 2025-09-15 15:45:39.143855 | Pipeline: check 2025-09-15 15:45:39.143881 | Executor: 521e9411259a 2025-09-15 15:45:39.143904 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/277 2025-09-15 15:45:39.143929 | Event ID: e8d16e80-924a-11f0-9779-4001dde41941 2025-09-15 15:45:39.148946 | 2025-09-15 15:45:39.149050 | LOOP [emit-job-header : Print node information] 2025-09-15 15:45:39.264404 | ubuntu-jammy | ok: 2025-09-15 15:45:39.264688 | ubuntu-jammy | # Node Information 2025-09-15 15:45:39.264745 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-09-15 15:45:39.264786 | ubuntu-jammy | Hostname: ubuntu 2025-09-15 15:45:39.264822 | ubuntu-jammy | Username: zuul 2025-09-15 15:45:39.264855 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-09-15 15:45:39.264894 | ubuntu-jammy | Provider: regiocloud-a 2025-09-15 15:45:39.264929 | ubuntu-jammy | Region: 2025-09-15 15:45:39.264963 | ubuntu-jammy | Label: ubuntu-jammy 2025-09-15 15:45:39.264995 | ubuntu-jammy | Product Name: OpenStack Nova 2025-09-15 15:45:39.265028 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:e851 2025-09-15 15:45:39.291150 | 2025-09-15 15:45:39.291299 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-15 15:45:39.758531 | ubuntu-jammy -> localhost | changed 2025-09-15 15:45:39.768782 | 2025-09-15 15:45:39.768927 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-15 15:45:40.797913 | ubuntu-jammy -> localhost | changed 2025-09-15 15:45:40.817253 | 2025-09-15 15:45:40.817394 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-15 15:45:41.084566 | ubuntu-jammy -> localhost | ok 2025-09-15 15:45:41.094705 | 2025-09-15 15:45:41.094893 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-15 15:45:41.130863 | ubuntu-jammy | ok 2025-09-15 15:45:41.152319 | ubuntu-jammy | included: /var/lib/zuul/builds/655232c533ef4dd890a3055ec459e72a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-15 15:45:41.158694 | 2025-09-15 15:45:41.158799 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-15 15:45:42.572474 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-09-15 15:45:42.572697 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/655232c533ef4dd890a3055ec459e72a/work/655232c533ef4dd890a3055ec459e72a_id_rsa 2025-09-15 15:45:42.572737 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/655232c533ef4dd890a3055ec459e72a/work/655232c533ef4dd890a3055ec459e72a_id_rsa.pub 2025-09-15 15:45:42.572764 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-09-15 15:45:42.572789 | ubuntu-jammy -> localhost | SHA256:Lwy6I7ccCbsBHzDaRCb74WLqHDdeeACiAQpfqBR1ADI zuul-build-sshkey 2025-09-15 15:45:42.572812 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-09-15 15:45:42.572849 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-09-15 15:45:42.572871 | ubuntu-jammy -> localhost | |Eo*+o. | 2025-09-15 15:45:42.572893 | ubuntu-jammy -> localhost | |=O... | 2025-09-15 15:45:42.572913 | ubuntu-jammy -> localhost | |Oo+ | 2025-09-15 15:45:42.572933 | ubuntu-jammy -> localhost | |=O.. | 2025-09-15 15:45:42.572953 | ubuntu-jammy -> localhost | |=.*. . S | 2025-09-15 15:45:42.572983 | ubuntu-jammy -> localhost | |o+ +oo o . | 2025-09-15 15:45:42.573004 | ubuntu-jammy -> localhost | |..+++o o . | 2025-09-15 15:45:42.573024 | ubuntu-jammy -> localhost | |o =+*o . | 2025-09-15 15:45:42.573045 | ubuntu-jammy -> localhost | | o.++o | 2025-09-15 15:45:42.573066 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-09-15 15:45:42.573133 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.916003 2025-09-15 15:45:42.579664 | 2025-09-15 15:45:42.579769 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-15 15:45:42.615230 | ubuntu-jammy | ok 2025-09-15 15:45:42.629893 | ubuntu-jammy | included: /var/lib/zuul/builds/655232c533ef4dd890a3055ec459e72a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-15 15:45:42.642106 | 2025-09-15 15:45:42.642258 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-15 15:45:42.666287 | ubuntu-jammy | skipping: Conditional result was False 2025-09-15 15:45:42.673674 | 2025-09-15 15:45:42.673787 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-15 15:45:43.310377 | ubuntu-jammy | changed 2025-09-15 15:45:43.316645 | 2025-09-15 15:45:43.316767 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-15 15:45:43.558241 | ubuntu-jammy | ok 2025-09-15 15:45:43.564104 | 2025-09-15 15:45:43.564237 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-15 15:45:44.201015 | ubuntu-jammy | changed 2025-09-15 15:45:44.211221 | 2025-09-15 15:45:44.211366 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-15 15:45:44.874068 | ubuntu-jammy | changed 2025-09-15 15:45:44.882634 | 2025-09-15 15:45:44.882766 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-15 15:45:44.907171 | ubuntu-jammy | skipping: Conditional result was False 2025-09-15 15:45:44.937586 | 2025-09-15 15:45:44.937736 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-15 15:45:45.441541 | ubuntu-jammy -> localhost | changed 2025-09-15 15:45:45.452745 | 2025-09-15 15:45:45.452878 | TASK [add-build-sshkey : Add back temp key] 2025-09-15 15:45:45.821924 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/655232c533ef4dd890a3055ec459e72a/work/655232c533ef4dd890a3055ec459e72a_id_rsa (zuul-build-sshkey) 2025-09-15 15:45:45.822199 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.029248 2025-09-15 15:45:45.830519 | 2025-09-15 15:45:45.830649 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-15 15:45:46.239853 | ubuntu-jammy | ok 2025-09-15 15:45:46.245370 | 2025-09-15 15:45:46.245483 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-15 15:45:46.269487 | ubuntu-jammy | skipping: Conditional result was False 2025-09-15 15:45:46.282009 | 2025-09-15 15:45:46.282150 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-15 15:45:46.711421 | ubuntu-jammy | ok 2025-09-15 15:45:46.734686 | 2025-09-15 15:45:46.734857 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-15 15:45:46.785222 | ubuntu-jammy | ok 2025-09-15 15:45:46.790787 | 2025-09-15 15:45:46.797266 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-15 15:45:47.207829 | ubuntu-jammy -> localhost | ok 2025-09-15 15:45:47.214407 | 2025-09-15 15:45:47.214515 | TASK [validate-host : Collect information about the host] 2025-09-15 15:45:48.419407 | ubuntu-jammy | ok 2025-09-15 15:45:48.442021 | 2025-09-15 15:45:48.442171 | TASK [validate-host : Sanitize hostname] 2025-09-15 15:45:48.567653 | ubuntu-jammy | ok 2025-09-15 15:45:48.610613 | 2025-09-15 15:45:48.610745 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-15 15:45:49.289096 | ubuntu-jammy -> localhost | changed 2025-09-15 15:45:49.302322 | 2025-09-15 15:45:49.302453 | TASK [validate-host : Collect information about zuul worker] 2025-09-15 15:45:49.708347 | ubuntu-jammy | ok 2025-09-15 15:45:49.715090 | 2025-09-15 15:45:49.715286 | TASK [validate-host : Write out all zuul information for each host] 2025-09-15 15:45:50.285204 | ubuntu-jammy -> localhost | changed 2025-09-15 15:45:50.297727 | 2025-09-15 15:45:50.297855 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-15 15:45:50.576547 | ubuntu-jammy | ok 2025-09-15 15:45:50.585570 | 2025-09-15 15:45:50.585716 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-15 15:45:51.545417 | ubuntu-jammy | changed: 2025-09-15 15:45:51.545697 | ubuntu-jammy | cd+++++++++ src/ 2025-09-15 15:45:51.545751 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-09-15 15:45:51.545789 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-09-15 15:45:51.545823 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-09-15 15:45:51.545854 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.546077 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.568156 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.568230 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.568300 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.568370 | ubuntu-jammy | Containerfile 2025-09-15 15:45:51.568441 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.008260 2025-09-15 15:46:18.982466 | 2025-09-15 15:46:18.982629 | TASK [upload-logs : Upload logs to log server] 2025-09-15 15:46:19.515304 | localhost | Output suppressed because no_log was given 2025-09-15 15:46:19.517224 | 2025-09-15 15:46:19.517329 | LOOP [upload-logs : Compress console log and json output] 2025-09-15 15:46:19.567529 | localhost | skipping: Conditional result was False 2025-09-15 15:46:19.572674 | localhost | skipping: Conditional result was False 2025-09-15 15:46:19.587892 | 2025-09-15 15:46:19.588105 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-15 15:46:19.638812 | localhost | skipping: Conditional result was False 2025-09-15 15:46:19.639527 | 2025-09-15 15:46:19.642909 | localhost | skipping: Conditional result was False 2025-09-15 15:46:19.649775 | 2025-09-15 15:46:19.649990 | LOOP [upload-logs : Upload console log and json output]