2025-05-30 11:47:32.820728 | Job console starting 2025-05-30 11:47:32.836107 | Updating git repos 2025-05-30 11:47:32.866638 | Cloning repos into workspace 2025-05-30 11:47:32.927374 | Restoring repo states 2025-05-30 11:47:32.933602 | Merging changes 2025-05-30 11:47:33.567677 | Checking out repos 2025-05-30 11:47:33.592334 | Preparing playbooks 2025-05-30 11:47:34.253468 | Running Ansible setup 2025-05-30 11:47:38.628499 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 11:47:39.619384 | 2025-05-30 11:47:39.619548 | PLAY [Base pre] 2025-05-30 11:47:39.645084 | 2025-05-30 11:47:39.645277 | TASK [Setup log path fact] 2025-05-30 11:47:39.675720 | ubuntu-jammy | ok 2025-05-30 11:47:39.699627 | 2025-05-30 11:47:39.699808 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 11:47:39.731050 | ubuntu-jammy | ok 2025-05-30 11:47:39.749887 | 2025-05-30 11:47:39.750662 | TASK [emit-job-header : Print job information] 2025-05-30 11:47:39.795881 | # Job Information 2025-05-30 11:47:39.796079 | Ansible Version: 2.16.14 2025-05-30 11:47:39.796115 | Job: python-black 2025-05-30 11:47:39.796147 | Pipeline: check 2025-05-30 11:47:39.796170 | Executor: 521e9411259a 2025-05-30 11:47:39.796191 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/218 2025-05-30 11:47:39.796213 | Event ID: bf3c5890-3d4b-11f0-8137-a94812808f2e 2025-05-30 11:47:39.803649 | 2025-05-30 11:47:39.805179 | LOOP [emit-job-header : Print node information] 2025-05-30 11:47:39.923887 | ubuntu-jammy | ok: 2025-05-30 11:47:39.924195 | ubuntu-jammy | # Node Information 2025-05-30 11:47:39.924306 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-05-30 11:47:39.924355 | ubuntu-jammy | Hostname: ubuntu 2025-05-30 11:47:39.924393 | ubuntu-jammy | Username: zuul 2025-05-30 11:47:39.924544 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-05-30 11:47:39.924598 | ubuntu-jammy | Provider: regiocloud-a 2025-05-30 11:47:39.924637 | ubuntu-jammy | Region: 2025-05-30 11:47:39.924675 | ubuntu-jammy | Label: ubuntu-jammy 2025-05-30 11:47:39.924710 | ubuntu-jammy | Product Name: OpenStack Nova 2025-05-30 11:47:39.924742 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe04:f48c 2025-05-30 11:47:39.961559 | 2025-05-30 11:47:39.961712 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 11:47:40.512453 | ubuntu-jammy -> localhost | changed 2025-05-30 11:47:40.520652 | 2025-05-30 11:47:40.520785 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 11:47:41.689909 | ubuntu-jammy -> localhost | changed 2025-05-30 11:47:41.701115 | 2025-05-30 11:47:41.701276 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 11:47:41.982597 | ubuntu-jammy -> localhost | ok 2025-05-30 11:47:41.990181 | 2025-05-30 11:47:41.990361 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 11:47:42.022883 | ubuntu-jammy | ok 2025-05-30 11:47:42.042745 | ubuntu-jammy | included: /var/lib/zuul/builds/fdde6336440b46808b4a825cf0dde1ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 11:47:42.049052 | 2025-05-30 11:47:42.049171 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 11:47:44.752998 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-05-30 11:47:44.753276 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/fdde6336440b46808b4a825cf0dde1ba/work/fdde6336440b46808b4a825cf0dde1ba_id_rsa 2025-05-30 11:47:44.753322 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/fdde6336440b46808b4a825cf0dde1ba/work/fdde6336440b46808b4a825cf0dde1ba_id_rsa.pub 2025-05-30 11:47:44.753353 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-05-30 11:47:44.753383 | ubuntu-jammy -> localhost | SHA256:M/W4Gf+/XA+b8Tf9LHA7SdxSdmDR+RuESw26/yyd7y8 zuul-build-sshkey 2025-05-30 11:47:44.753409 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-05-30 11:47:44.753450 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-05-30 11:47:44.753475 | ubuntu-jammy -> localhost | | .=o.| 2025-05-30 11:47:44.753498 | ubuntu-jammy -> localhost | | .oo+.| 2025-05-30 11:47:44.753521 | ubuntu-jammy -> localhost | | ....o..| 2025-05-30 11:47:44.753544 | ubuntu-jammy -> localhost | | . o.. .=| 2025-05-30 11:47:44.753566 | ubuntu-jammy -> localhost | | S o... ++| 2025-05-30 11:47:44.753594 | ubuntu-jammy -> localhost | | o =o =..| 2025-05-30 11:47:44.753617 | ubuntu-jammy -> localhost | | o .=+++| 2025-05-30 11:47:44.753640 | ubuntu-jammy -> localhost | | oE@=| 2025-05-30 11:47:44.753663 | ubuntu-jammy -> localhost | | =@^| 2025-05-30 11:47:44.753686 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-05-30 11:47:44.753753 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:02.194794 2025-05-30 11:47:44.761045 | 2025-05-30 11:47:44.761162 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 11:47:44.804172 | ubuntu-jammy | ok 2025-05-30 11:47:44.818108 | ubuntu-jammy | included: /var/lib/zuul/builds/fdde6336440b46808b4a825cf0dde1ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 11:47:44.828014 | 2025-05-30 11:47:44.828120 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 11:47:44.851999 | ubuntu-jammy | skipping: Conditional result was False 2025-05-30 11:47:44.858883 | 2025-05-30 11:47:44.858987 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 11:47:45.563028 | ubuntu-jammy | changed 2025-05-30 11:47:45.577923 | 2025-05-30 11:47:45.578118 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 11:47:45.828796 | ubuntu-jammy | ok 2025-05-30 11:47:45.838617 | 2025-05-30 11:47:45.838768 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 11:47:46.524875 | ubuntu-jammy | changed 2025-05-30 11:47:46.532100 | 2025-05-30 11:47:46.532257 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 11:47:47.254814 | ubuntu-jammy | changed 2025-05-30 11:47:47.267161 | 2025-05-30 11:47:47.267943 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 11:47:47.304482 | ubuntu-jammy | skipping: Conditional result was False 2025-05-30 11:47:47.311150 | 2025-05-30 11:47:47.311297 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 11:47:47.782895 | ubuntu-jammy -> localhost | changed 2025-05-30 11:47:47.796215 | 2025-05-30 11:47:47.796378 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 11:47:48.179265 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/fdde6336440b46808b4a825cf0dde1ba/work/fdde6336440b46808b4a825cf0dde1ba_id_rsa (zuul-build-sshkey) 2025-05-30 11:47:48.179642 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.021251 2025-05-30 11:47:48.192996 | 2025-05-30 11:47:48.193131 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 11:47:48.616399 | ubuntu-jammy | ok 2025-05-30 11:47:48.621776 | 2025-05-30 11:47:48.621893 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 11:47:48.655721 | ubuntu-jammy | skipping: Conditional result was False 2025-05-30 11:47:48.667103 | 2025-05-30 11:47:48.667223 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 11:47:49.094331 | ubuntu-jammy | ok 2025-05-30 11:47:49.109739 | 2025-05-30 11:47:49.109884 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 11:47:49.151567 | ubuntu-jammy | ok 2025-05-30 11:47:49.157102 | 2025-05-30 11:47:49.157214 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 11:47:49.466312 | ubuntu-jammy -> localhost | ok 2025-05-30 11:47:49.481003 | 2025-05-30 11:47:49.481162 | TASK [validate-host : Collect information about the host] 2025-05-30 11:47:50.628803 | ubuntu-jammy | ok 2025-05-30 11:47:50.665030 | 2025-05-30 11:47:50.665177 | TASK [validate-host : Sanitize hostname] 2025-05-30 11:47:50.777059 | ubuntu-jammy | ok 2025-05-30 11:47:50.822944 | 2025-05-30 11:47:50.823081 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 11:47:51.383172 | ubuntu-jammy -> localhost | changed 2025-05-30 11:47:51.390075 | 2025-05-30 11:47:51.390206 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 11:47:51.785982 | ubuntu-jammy | ok 2025-05-30 11:47:51.793968 | 2025-05-30 11:47:51.794103 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 11:47:52.394740 | ubuntu-jammy -> localhost | changed 2025-05-30 11:47:52.404637 | 2025-05-30 11:47:52.404752 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 11:47:52.685512 | ubuntu-jammy | ok 2025-05-30 11:47:52.691454 | 2025-05-30 11:47:52.691575 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 11:47:53.643626 | ubuntu-jammy | changed: 2025-05-30 11:47:53.643886 | ubuntu-jammy | cd+++++++++ src/ 2025-05-30 11:47:53.643922 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-05-30 11:47:53.643948 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-05-30 11:47:53.643970 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-05-30 11:47:53.643991 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.644143 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674419 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674490 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674560 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674629 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674698 | ubuntu-jammy | Containerfile 2025-05-30 11:47:53.674770 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.006603 2025-05-30 11:48:21.497413 | 2025-05-30 11:48:21.497610 | TASK [upload-logs : Upload logs to log server] 2025-05-30 11:48:22.062283 | localhost | Output suppressed because no_log was given 2025-05-30 11:48:22.065381 | 2025-05-30 11:48:22.065538 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 11:48:22.121860 | localhost | skipping: Conditional result was False 2025-05-30 11:48:22.129842 | localhost | skipping: Conditional result was False 2025-05-30 11:48:22.143125 | 2025-05-30 11:48:22.143285 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 11:48:22.205368 | localhost | skipping: Conditional result was False 2025-05-30 11:48:22.205727 | 2025-05-30 11:48:22.212541 | localhost | skipping: Conditional result was False 2025-05-30 11:48:22.221987 | 2025-05-30 11:48:22.222113 | LOOP [upload-logs : Upload console log and json output]