2025-03-28 10:23:54.835327 | Job console starting... 2025-03-28 10:23:54.854370 | Updating repositories 2025-03-28 10:23:54.900719 | Preparing job workspace 2025-03-28 10:23:56.631895 | Running Ansible setup... 2025-03-28 10:24:01.620217 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-28 10:24:02.422914 | 2025-03-28 10:24:02.423094 | PLAY [Base pre] 2025-03-28 10:24:02.452254 | 2025-03-28 10:24:02.452414 | TASK [Setup log path fact] 2025-03-28 10:24:02.496013 | ubuntu-noble | ok 2025-03-28 10:24:02.516528 | 2025-03-28 10:24:02.517695 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-28 10:24:02.558972 | ubuntu-noble | ok 2025-03-28 10:24:02.571883 | 2025-03-28 10:24:02.572011 | TASK [emit-job-header : Print job information] 2025-03-28 10:24:02.625397 | # Job Information 2025-03-28 10:24:02.625570 | Ansible Version: 2.15.3 2025-03-28 10:24:02.625603 | Job: python-black 2025-03-28 10:24:02.625635 | Pipeline: check 2025-03-28 10:24:02.625656 | Executor: 7d211f194f6a 2025-03-28 10:24:02.625675 | Triggered by: https://github.com/osism/testbed/pull/2649 2025-03-28 10:24:02.625693 | Event ID: bbdcd8f0-0bbe-11f0-9f3a-f5b233067621 2025-03-28 10:24:02.632367 | 2025-03-28 10:24:02.632515 | LOOP [emit-job-header : Print node information] 2025-03-28 10:24:02.770863 | ubuntu-noble | ok: 2025-03-28 10:24:02.771177 | ubuntu-noble | # Node Information 2025-03-28 10:24:02.771222 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-28 10:24:02.771248 | ubuntu-noble | Hostname: ubuntu 2025-03-28 10:24:02.771270 | ubuntu-noble | Username: zuul 2025-03-28 10:24:02.771291 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-28 10:24:02.771315 | ubuntu-noble | Provider: regiocloud-a 2025-03-28 10:24:02.771336 | ubuntu-noble | Label: ubuntu-noble 2025-03-28 10:24:02.771358 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-28 10:24:02.771378 | ubuntu-noble | Interface IP: 81.163.193.39 2025-03-28 10:24:02.795230 | 2025-03-28 10:24:02.795373 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-28 10:24:03.280312 | ubuntu-noble -> localhost | changed 2025-03-28 10:24:03.288413 | 2025-03-28 10:24:03.288509 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-28 10:24:04.333632 | ubuntu-noble -> localhost | changed 2025-03-28 10:24:04.363415 | 2025-03-28 10:24:04.363555 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-28 10:24:04.784946 | ubuntu-noble -> localhost | ok 2025-03-28 10:24:04.845468 | 2025-03-28 10:24:04.845579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-28 10:24:04.921463 | ubuntu-noble | ok 2025-03-28 10:24:04.956132 | ubuntu-noble | included: /var/lib/zuul/builds/596e3a5201db430ea420a0e4a07c2b24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-28 10:24:04.962943 | 2025-03-28 10:24:04.963028 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-28 10:24:05.953499 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-28 10:24:05.953669 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/596e3a5201db430ea420a0e4a07c2b24/work/596e3a5201db430ea420a0e4a07c2b24_id_rsa 2025-03-28 10:24:05.953702 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/596e3a5201db430ea420a0e4a07c2b24/work/596e3a5201db430ea420a0e4a07c2b24_id_rsa.pub 2025-03-28 10:24:05.953725 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-28 10:24:05.953747 | ubuntu-noble -> localhost | SHA256:9Zg8yqc6EEJ4TBjj5cyk47y/IqhuwmesoV4iXJNYkrA zuul-build-sshkey 2025-03-28 10:24:05.953768 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-28 10:24:05.953788 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-28 10:24:05.953808 | ubuntu-noble -> localhost | |+*.o | 2025-03-28 10:24:05.953827 | ubuntu-noble -> localhost | |=o% | 2025-03-28 10:24:05.953847 | ubuntu-noble -> localhost | |EO = . | 2025-03-28 10:24:05.953875 | ubuntu-noble -> localhost | |o * o o + | 2025-03-28 10:24:05.953896 | ubuntu-noble -> localhost | | + = . S = . | 2025-03-28 10:24:05.953915 | ubuntu-noble -> localhost | |. o o . . . | 2025-03-28 10:24:05.953937 | ubuntu-noble -> localhost | |+=.. . o . | 2025-03-28 10:24:05.953957 | ubuntu-noble -> localhost | |*+=+ . o | 2025-03-28 10:24:05.953976 | ubuntu-noble -> localhost | |X+=o. .o. | 2025-03-28 10:24:05.954012 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-28 10:24:05.954061 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.454543 2025-03-28 10:24:05.961486 | 2025-03-28 10:24:05.961576 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-28 10:24:05.991233 | ubuntu-noble | ok 2025-03-28 10:24:06.001613 | ubuntu-noble | included: /var/lib/zuul/builds/596e3a5201db430ea420a0e4a07c2b24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-28 10:24:06.010728 | 2025-03-28 10:24:06.010809 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-28 10:24:06.034581 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 10:24:06.041418 | 2025-03-28 10:24:06.041504 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-28 10:24:06.851584 | ubuntu-noble | changed 2025-03-28 10:24:06.860816 | 2025-03-28 10:24:06.860914 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-28 10:24:07.269189 | ubuntu-noble | ok 2025-03-28 10:24:07.279406 | 2025-03-28 10:24:07.279529 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-28 10:24:08.096037 | ubuntu-noble | changed 2025-03-28 10:24:08.105622 | 2025-03-28 10:24:08.105721 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-28 10:24:08.953009 | ubuntu-noble | changed 2025-03-28 10:24:08.961900 | 2025-03-28 10:24:08.962038 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-28 10:24:08.985934 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 10:24:08.995586 | 2025-03-28 10:24:08.995685 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-28 10:24:09.386549 | ubuntu-noble -> localhost | changed 2025-03-28 10:24:09.400311 | 2025-03-28 10:24:09.400420 | TASK [add-build-sshkey : Add back temp key] 2025-03-28 10:24:09.678478 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/596e3a5201db430ea420a0e4a07c2b24/work/596e3a5201db430ea420a0e4a07c2b24_id_rsa (zuul-build-sshkey) 2025-03-28 10:24:09.678638 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014590 2025-03-28 10:24:09.686132 | 2025-03-28 10:24:09.686215 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-28 10:24:10.102500 | ubuntu-noble | ok 2025-03-28 10:24:10.110915 | 2025-03-28 10:24:10.111015 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-28 10:24:10.149077 | ubuntu-noble | skipping: Conditional result was False 2025-03-28 10:24:10.163722 | 2025-03-28 10:24:10.163816 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-28 10:24:10.660236 | ubuntu-noble | ok 2025-03-28 10:24:10.677478 | 2025-03-28 10:24:10.677601 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-28 10:24:10.709042 | ubuntu-noble | ok 2025-03-28 10:24:10.720511 | 2025-03-28 10:24:10.720680 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-28 10:24:10.959975 | ubuntu-noble -> localhost | ok 2025-03-28 10:24:10.966173 | 2025-03-28 10:24:10.966250 | TASK [validate-host : Collect information about the host] 2025-03-28 10:24:12.235676 | ubuntu-noble | ok 2025-03-28 10:24:12.250107 | 2025-03-28 10:24:12.250209 | TASK [validate-host : Sanitize hostname] 2025-03-28 10:24:12.321730 | ubuntu-noble | ok 2025-03-28 10:24:12.331328 | 2025-03-28 10:24:12.331440 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-28 10:24:12.804282 | ubuntu-noble -> localhost | changed 2025-03-28 10:24:12.810659 | 2025-03-28 10:24:12.810756 | TASK [validate-host : Collect information about zuul worker] 2025-03-28 10:24:13.339708 | ubuntu-noble | ok 2025-03-28 10:24:13.345705 | 2025-03-28 10:24:13.345790 | TASK [validate-host : Write out all zuul information for each host] 2025-03-28 10:24:13.868809 | ubuntu-noble -> localhost | changed 2025-03-28 10:24:13.888634 | 2025-03-28 10:24:13.888735 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-28 10:24:14.320606 | ubuntu-noble | ok 2025-03-28 10:24:14.335053 | 2025-03-28 10:24:14.335186 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-28 10:24:15.716494 | ubuntu-noble | changed: 2025-03-28 10:24:15.716806 | ubuntu-noble | cd+++++++++ src/ 2025-03-28 10:24:15.716879 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-28 10:24:15.716917 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-28 10:24:15.716947 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-28 10:24:15.716975 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007678 2025-03-28 10:24:54.642276 | 2025-03-28 10:24:54.642388 | TASK [upload-logs : Upload logs to log server] 2025-03-28 10:24:55.280198 | localhost | Output suppressed because no_log was given 2025-03-28 10:24:55.283504 | 2025-03-28 10:24:55.283613 | LOOP [upload-logs : Compress console log and json output] 2025-03-28 10:24:55.351498 | localhost | skipping: Conditional result was False 2025-03-28 10:24:55.370416 | localhost | skipping: Conditional result was False 2025-03-28 10:24:55.384428 | 2025-03-28 10:24:55.384542 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-28 10:24:55.455541 | localhost | skipping: Conditional result was False 2025-03-28 10:24:55.455845 | 2025-03-28 10:24:55.469092 | localhost | skipping: Conditional result was False 2025-03-28 10:24:55.475094 | 2025-03-28 10:24:55.475241 | LOOP [upload-logs : Upload console log and json output]