2025-09-11 11:07:50.617550 | Job console starting 2025-09-11 11:07:50.637943 | Updating git repos 2025-09-11 11:07:50.673373 | Cloning repos into workspace 2025-09-11 11:07:50.736276 | Restoring repo states 2025-09-11 11:07:50.743121 | Merging changes 2025-09-11 11:07:51.309523 | Checking out repos 2025-09-11 11:07:51.345236 | Preparing playbooks 2025-09-11 11:07:51.838356 | Running Ansible setup 2025-09-11 11:07:55.958556 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-09-11 11:07:56.728598 | 2025-09-11 11:07:56.728773 | PLAY [Base pre] 2025-09-11 11:07:56.745205 | 2025-09-11 11:07:56.745338 | TASK [Setup log path fact] 2025-09-11 11:07:56.764043 | ubuntu-jammy | ok 2025-09-11 11:07:56.779582 | 2025-09-11 11:07:56.779717 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-11 11:07:56.809206 | ubuntu-jammy | ok 2025-09-11 11:07:56.818930 | 2025-09-11 11:07:56.819036 | TASK [emit-job-header : Print job information] 2025-09-11 11:07:56.865176 | # Job Information 2025-09-11 11:07:56.865478 | Ansible Version: 2.16.14 2025-09-11 11:07:56.865552 | Job: python-black 2025-09-11 11:07:56.865619 | Pipeline: check 2025-09-11 11:07:56.865669 | Executor: 521e9411259a 2025-09-11 11:07:56.865712 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/257 2025-09-11 11:07:56.865824 | Event ID: 74bbba30-8eff-11f0-8bfc-dfd553c708e1 2025-09-11 11:07:56.875444 | 2025-09-11 11:07:56.875588 | LOOP [emit-job-header : Print node information] 2025-09-11 11:07:56.991572 | ubuntu-jammy | ok: 2025-09-11 11:07:56.991853 | ubuntu-jammy | # Node Information 2025-09-11 11:07:56.991912 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-09-11 11:07:56.991954 | ubuntu-jammy | Hostname: ubuntu 2025-09-11 11:07:56.991992 | ubuntu-jammy | Username: zuul 2025-09-11 11:07:56.992026 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-09-11 11:07:56.992066 | ubuntu-jammy | Provider: regiocloud-a 2025-09-11 11:07:56.992102 | ubuntu-jammy | Region: 2025-09-11 11:07:56.992136 | ubuntu-jammy | Label: ubuntu-jammy 2025-09-11 11:07:56.992236 | ubuntu-jammy | Product Name: OpenStack Nova 2025-09-11 11:07:56.992275 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6f:cbc9 2025-09-11 11:07:57.013347 | 2025-09-11 11:07:57.013478 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-11 11:07:57.473030 | ubuntu-jammy -> localhost | changed 2025-09-11 11:07:57.484576 | 2025-09-11 11:07:57.484875 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-11 11:07:58.570894 | ubuntu-jammy -> localhost | changed 2025-09-11 11:07:58.585975 | 2025-09-11 11:07:58.586116 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-11 11:07:58.848063 | ubuntu-jammy -> localhost | ok 2025-09-11 11:07:58.856845 | 2025-09-11 11:07:58.857010 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-11 11:07:58.886134 | ubuntu-jammy | ok 2025-09-11 11:07:58.904591 | ubuntu-jammy | included: /var/lib/zuul/builds/c0cda2f11eff46c5ac0d966c0fe38556/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-11 11:07:58.911121 | 2025-09-11 11:07:58.911244 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-11 11:08:00.382012 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-09-11 11:08:00.382324 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/c0cda2f11eff46c5ac0d966c0fe38556/work/c0cda2f11eff46c5ac0d966c0fe38556_id_rsa 2025-09-11 11:08:00.382380 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/c0cda2f11eff46c5ac0d966c0fe38556/work/c0cda2f11eff46c5ac0d966c0fe38556_id_rsa.pub 2025-09-11 11:08:00.382413 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-09-11 11:08:00.382441 | ubuntu-jammy -> localhost | SHA256:lk+IOHI7lH3W/2N5J0uodpr4I2Vf6rl2nwkp563hoY4 zuul-build-sshkey 2025-09-11 11:08:00.382467 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-09-11 11:08:00.382503 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-09-11 11:08:00.382530 | ubuntu-jammy -> localhost | | | 2025-09-11 11:08:00.382555 | ubuntu-jammy -> localhost | | | 2025-09-11 11:08:00.382578 | ubuntu-jammy -> localhost | | | 2025-09-11 11:08:00.382601 | ubuntu-jammy -> localhost | | + . + | 2025-09-11 11:08:00.382623 | ubuntu-jammy -> localhost | | . * o S o | 2025-09-11 11:08:00.382652 | ubuntu-jammy -> localhost | | + o + oo. .o | 2025-09-11 11:08:00.382674 | ubuntu-jammy -> localhost | | o o.ooO.. | 2025-09-11 11:08:00.382696 | ubuntu-jammy -> localhost | | . ..+o@+@ =| 2025-09-11 11:08:00.382720 | ubuntu-jammy -> localhost | | .E*O+B+Xo| 2025-09-11 11:08:00.382804 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-09-11 11:08:00.382908 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.940425 2025-09-11 11:08:00.394767 | 2025-09-11 11:08:00.394977 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-11 11:08:00.434029 | ubuntu-jammy | ok 2025-09-11 11:08:00.445899 | ubuntu-jammy | included: /var/lib/zuul/builds/c0cda2f11eff46c5ac0d966c0fe38556/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-11 11:08:00.457217 | 2025-09-11 11:08:00.457353 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-11 11:08:00.481711 | ubuntu-jammy | skipping: Conditional result was False 2025-09-11 11:08:00.494704 | 2025-09-11 11:08:00.494909 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-11 11:08:01.054861 | ubuntu-jammy | changed 2025-09-11 11:08:01.060991 | 2025-09-11 11:08:01.061106 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-11 11:08:01.290622 | ubuntu-jammy | ok 2025-09-11 11:08:01.296242 | 2025-09-11 11:08:01.296354 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-11 11:08:01.876616 | ubuntu-jammy | changed 2025-09-11 11:08:01.884558 | 2025-09-11 11:08:01.884677 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-11 11:08:02.466311 | ubuntu-jammy | changed 2025-09-11 11:08:02.471983 | 2025-09-11 11:08:02.472091 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-11 11:08:02.495605 | ubuntu-jammy | skipping: Conditional result was False 2025-09-11 11:08:02.502259 | 2025-09-11 11:08:02.502367 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-11 11:08:02.927121 | ubuntu-jammy -> localhost | changed 2025-09-11 11:08:02.954674 | 2025-09-11 11:08:02.955147 | TASK [add-build-sshkey : Add back temp key] 2025-09-11 11:08:03.305316 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/c0cda2f11eff46c5ac0d966c0fe38556/work/c0cda2f11eff46c5ac0d966c0fe38556_id_rsa (zuul-build-sshkey) 2025-09-11 11:08:03.305580 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.011032 2025-09-11 11:08:03.313647 | 2025-09-11 11:08:03.313802 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-11 11:08:03.699287 | ubuntu-jammy | ok 2025-09-11 11:08:03.704489 | 2025-09-11 11:08:03.704595 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-11 11:08:03.738792 | ubuntu-jammy | skipping: Conditional result was False 2025-09-11 11:08:03.752582 | 2025-09-11 11:08:03.752720 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-11 11:08:04.224321 | ubuntu-jammy | ok 2025-09-11 11:08:04.241331 | 2025-09-11 11:08:04.241471 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-11 11:08:04.293929 | ubuntu-jammy | ok 2025-09-11 11:08:04.299169 | 2025-09-11 11:08:04.299281 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-11 11:08:04.659905 | ubuntu-jammy -> localhost | ok 2025-09-11 11:08:04.666334 | 2025-09-11 11:08:04.666435 | TASK [validate-host : Collect information about the host] 2025-09-11 11:08:05.812755 | ubuntu-jammy | ok 2025-09-11 11:08:05.823625 | 2025-09-11 11:08:05.823772 | TASK [validate-host : Sanitize hostname] 2025-09-11 11:08:05.917894 | ubuntu-jammy | ok 2025-09-11 11:08:05.957772 | 2025-09-11 11:08:05.957893 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-11 11:08:06.488662 | ubuntu-jammy -> localhost | changed 2025-09-11 11:08:06.495221 | 2025-09-11 11:08:06.495338 | TASK [validate-host : Collect information about zuul worker] 2025-09-11 11:08:06.894415 | ubuntu-jammy | ok 2025-09-11 11:08:06.899628 | 2025-09-11 11:08:06.899781 | TASK [validate-host : Write out all zuul information for each host] 2025-09-11 11:08:07.529111 | ubuntu-jammy -> localhost | changed 2025-09-11 11:08:07.547993 | 2025-09-11 11:08:07.548140 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-11 11:08:07.784969 | ubuntu-jammy | ok 2025-09-11 11:08:07.794694 | 2025-09-11 11:08:07.794927 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-11 11:08:08.680788 | ubuntu-jammy | changed: 2025-09-11 11:08:08.681253 | ubuntu-jammy | cd+++++++++ src/ 2025-09-11 11:08:08.681396 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-09-11 11:08:08.681512 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-09-11 11:08:08.681611 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-09-11 11:08:08.681709 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.682229 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.704207 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.704301 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.704398 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.704488 | ubuntu-jammy | Containerfile 2025-09-11 11:08:08.704566 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.007211 2025-09-11 11:08:36.316382 | 2025-09-11 11:08:36.316572 | TASK [upload-logs : Upload logs to log server] 2025-09-11 11:08:36.844229 | localhost | Output suppressed because no_log was given 2025-09-11 11:08:36.846343 | 2025-09-11 11:08:36.846585 | LOOP [upload-logs : Compress console log and json output] 2025-09-11 11:08:36.912442 | localhost | skipping: Conditional result was False 2025-09-11 11:08:36.918595 | localhost | skipping: Conditional result was False 2025-09-11 11:08:36.926172 | 2025-09-11 11:08:36.926351 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-11 11:08:36.984273 | localhost | skipping: Conditional result was False 2025-09-11 11:08:36.985047 | 2025-09-11 11:08:36.990563 | localhost | skipping: Conditional result was False 2025-09-11 11:08:37.004464 | 2025-09-11 11:08:37.004599 | LOOP [upload-logs : Upload console log and json output]