2025-02-18 19:08:13.117869 | Job console starting... 2025-02-18 19:08:13.129130 | Updating repositories 2025-02-18 19:08:13.188914 | Preparing job workspace 2025-02-18 19:08:15.269092 | Running Ansible setup... 2025-02-18 19:08:20.783330 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-02-18 19:08:21.463792 | 2025-02-18 19:08:21.463901 | PLAY [Base pre] 2025-02-18 19:08:21.502332 | 2025-02-18 19:08:21.502462 | TASK [Setup log path fact] 2025-02-18 19:08:21.521716 | ubuntu-jammy | ok 2025-02-18 19:08:21.552638 | 2025-02-18 19:08:21.552751 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 19:08:21.612287 | ubuntu-jammy | ok 2025-02-18 19:08:21.617891 | 2025-02-18 19:08:21.617987 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 19:08:21.652194 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:21.662802 | 2025-02-18 19:08:21.662918 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 19:08:21.707024 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:21.713873 | 2025-02-18 19:08:21.713957 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 19:08:21.737366 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:21.744870 | 2025-02-18 19:08:21.744948 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 19:08:21.769212 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:21.776509 | 2025-02-18 19:08:21.776592 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 19:08:21.820079 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:21.834216 | 2025-02-18 19:08:21.834306 | TASK [emit-job-header : Print job information] 2025-02-18 19:08:21.886766 | # Job Information 2025-02-18 19:08:21.886917 | Ansible Version: 2.15.3 2025-02-18 19:08:21.886949 | Job: python-black 2025-02-18 19:08:21.886977 | Pipeline: check 2025-02-18 19:08:21.886997 | Executor: 7d211f194f6a 2025-02-18 19:08:21.887015 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/127 2025-02-18 19:08:21.887033 | Event ID: 901eb270-ee2b-11ef-8fba-45ffa4f1bd37 2025-02-18 19:08:21.894872 | 2025-02-18 19:08:21.894962 | LOOP [emit-job-header : Print node information] 2025-02-18 19:08:22.035823 | ubuntu-jammy | ok: 2025-02-18 19:08:22.035978 | ubuntu-jammy | # Node Information 2025-02-18 19:08:22.036012 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-02-18 19:08:22.036035 | ubuntu-jammy | Hostname: ubuntu 2025-02-18 19:08:22.036057 | ubuntu-jammy | Username: zuul 2025-02-18 19:08:22.036077 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-02-18 19:08:22.036097 | ubuntu-jammy | Provider: regiocloud-a 2025-02-18 19:08:22.036115 | ubuntu-jammy | Label: ubuntu-jammy 2025-02-18 19:08:22.036134 | ubuntu-jammy | Product Name: OpenStack Nova 2025-02-18 19:08:22.036154 | ubuntu-jammy | Interface IP: 81.163.192.170 2025-02-18 19:08:22.053688 | 2025-02-18 19:08:22.053789 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-18 19:08:22.532019 | ubuntu-jammy -> localhost | changed 2025-02-18 19:08:22.539939 | 2025-02-18 19:08:22.540031 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-18 19:08:23.592586 | ubuntu-jammy -> localhost | changed 2025-02-18 19:08:23.605972 | 2025-02-18 19:08:23.606066 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-18 19:08:23.894138 | ubuntu-jammy -> localhost | ok 2025-02-18 19:08:23.901550 | 2025-02-18 19:08:23.901644 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-18 19:08:23.941486 | ubuntu-jammy | ok 2025-02-18 19:08:23.961720 | ubuntu-jammy | included: /var/lib/zuul/builds/a6925a1b939849ca94ea862658ca6312/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-18 19:08:23.969255 | 2025-02-18 19:08:23.969341 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-18 19:08:24.770474 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-02-18 19:08:24.770698 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6925a1b939849ca94ea862658ca6312/work/a6925a1b939849ca94ea862658ca6312_id_rsa 2025-02-18 19:08:24.770737 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6925a1b939849ca94ea862658ca6312/work/a6925a1b939849ca94ea862658ca6312_id_rsa.pub 2025-02-18 19:08:24.770761 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-02-18 19:08:24.770783 | ubuntu-jammy -> localhost | SHA256:V/Ytt5NMNtz/0JGPjGxqrswMshVsidy+uO+YS1IZGRg zuul-build-sshkey 2025-02-18 19:08:24.770805 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-02-18 19:08:24.770830 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-02-18 19:08:24.770850 | ubuntu-jammy -> localhost | | Eo. | 2025-02-18 19:08:24.770870 | ubuntu-jammy -> localhost | | . o | 2025-02-18 19:08:24.770889 | ubuntu-jammy -> localhost | | o o | 2025-02-18 19:08:24.770908 | ubuntu-jammy -> localhost | | . * . o ...o| 2025-02-18 19:08:24.770926 | ubuntu-jammy -> localhost | | = * S . oB+| 2025-02-18 19:08:24.770945 | ubuntu-jammy -> localhost | | . o . . . o+=B| 2025-02-18 19:08:24.770964 | ubuntu-jammy -> localhost | | . o + + +=+| 2025-02-18 19:08:24.770983 | ubuntu-jammy -> localhost | | o B * .o .o| 2025-02-18 19:08:24.771003 | ubuntu-jammy -> localhost | | B=+ =+o .| 2025-02-18 19:08:24.771021 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-02-18 19:08:24.771068 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.306109 2025-02-18 19:08:24.778737 | 2025-02-18 19:08:24.778830 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-18 19:08:24.808161 | ubuntu-jammy | ok 2025-02-18 19:08:24.819482 | ubuntu-jammy | included: /var/lib/zuul/builds/a6925a1b939849ca94ea862658ca6312/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-18 19:08:24.829020 | 2025-02-18 19:08:24.829105 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-18 19:08:24.852831 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:24.860141 | 2025-02-18 19:08:24.860242 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-18 19:08:25.439032 | ubuntu-jammy | changed 2025-02-18 19:08:25.449782 | 2025-02-18 19:08:25.449928 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-18 19:08:25.704644 | ubuntu-jammy | ok 2025-02-18 19:08:25.712326 | 2025-02-18 19:08:25.712497 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-18 19:08:26.333052 | ubuntu-jammy | changed 2025-02-18 19:08:26.341431 | 2025-02-18 19:08:26.341552 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-18 19:08:26.945785 | ubuntu-jammy | changed 2025-02-18 19:08:26.958568 | 2025-02-18 19:08:26.958702 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-18 19:08:26.983677 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:26.993472 | 2025-02-18 19:08:26.995023 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-18 19:08:27.622175 | ubuntu-jammy -> localhost | changed 2025-02-18 19:08:27.636034 | 2025-02-18 19:08:27.636161 | TASK [add-build-sshkey : Add back temp key] 2025-02-18 19:08:28.014288 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/a6925a1b939849ca94ea862658ca6312/work/a6925a1b939849ca94ea862658ca6312_id_rsa (zuul-build-sshkey) 2025-02-18 19:08:28.014730 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.016497 2025-02-18 19:08:28.039260 | 2025-02-18 19:08:28.039497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-18 19:08:28.498849 | ubuntu-jammy | ok 2025-02-18 19:08:28.505653 | 2025-02-18 19:08:28.505768 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-18 19:08:28.537360 | ubuntu-jammy | skipping: Conditional result was False 2025-02-18 19:08:28.551438 | 2025-02-18 19:08:28.551582 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-18 19:08:28.943495 | ubuntu-jammy | ok 2025-02-18 19:08:28.959544 | 2025-02-18 19:08:28.959671 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-18 19:08:29.001502 | ubuntu-jammy | ok 2025-02-18 19:08:29.008336 | 2025-02-18 19:08:29.008524 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-18 19:08:29.391394 | ubuntu-jammy -> localhost | ok 2025-02-18 19:08:29.399619 | 2025-02-18 19:08:29.399735 | TASK [validate-host : Collect information about the host] 2025-02-18 19:08:30.663326 | ubuntu-jammy | ok 2025-02-18 19:08:30.701758 | 2025-02-18 19:08:30.701909 | TASK [validate-host : Sanitize hostname] 2025-02-18 19:08:30.798357 | ubuntu-jammy | ok 2025-02-18 19:08:30.805465 | 2025-02-18 19:08:30.805597 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-18 19:08:31.426178 | ubuntu-jammy -> localhost | changed 2025-02-18 19:08:31.434057 | 2025-02-18 19:08:31.434177 | TASK [validate-host : Collect information about zuul worker] 2025-02-18 19:08:31.926336 | ubuntu-jammy | ok 2025-02-18 19:08:31.932832 | 2025-02-18 19:08:31.932952 | TASK [validate-host : Write out all zuul information for each host] 2025-02-18 19:08:32.527735 | ubuntu-jammy -> localhost | changed 2025-02-18 19:08:32.551447 | 2025-02-18 19:08:32.551582 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-18 19:08:32.817919 | ubuntu-jammy | ok 2025-02-18 19:08:32.828734 | 2025-02-18 19:08:32.828868 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-18 19:08:33.808203 | ubuntu-jammy | changed: 2025-02-18 19:08:33.808599 | ubuntu-jammy | cd+++++++++ src/ 2025-02-18 19:08:33.808650 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-02-18 19:08:33.808677 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-02-18 19:08:33.808699 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-02-18 19:08:33.808721 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.808870 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.843836 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.843906 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.843976 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.844050 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.844120 | ubuntu-jammy | Containerfile 2025-02-18 19:08:33.844190 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.005633 2025-02-18 19:09:00.822521 | 2025-02-18 19:09:00.822639 | TASK [upload-logs : Upload logs to log server] 2025-02-18 19:09:01.504150 | localhost | Output suppressed because no_log was given 2025-02-18 19:09:01.515604 | 2025-02-18 19:09:01.515746 | LOOP [upload-logs : Compress console log and json output] 2025-02-18 19:09:01.612660 | localhost | skipping: Conditional result was False 2025-02-18 19:09:01.626272 | localhost | skipping: Conditional result was False 2025-02-18 19:09:01.631683 | 2025-02-18 19:09:01.631805 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-18 19:09:01.713154 | localhost | skipping: Conditional result was False 2025-02-18 19:09:01.713500 | 2025-02-18 19:09:01.714330 | localhost | skipping: Conditional result was False 2025-02-18 19:09:01.725526 | 2025-02-18 19:09:01.725658 | LOOP [upload-logs : Upload console log and json output]