2025-04-18 03:15:19.404490 | Job console starting... 2025-04-18 03:15:19.412631 | Updating repositories 2025-04-18 03:15:19.477431 | Preparing job workspace 2025-04-18 03:15:21.595939 | Running Ansible setup... 2025-04-18 03:15:28.170570 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-18 03:15:29.359682 | 2025-04-18 03:15:29.359817 | PLAY [Base pre] 2025-04-18 03:15:29.406791 | 2025-04-18 03:15:29.406914 | TASK [Setup log path fact] 2025-04-18 03:15:29.443534 | ubuntu-noble | ok 2025-04-18 03:15:29.480328 | 2025-04-18 03:15:29.480522 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-18 03:15:29.524095 | ubuntu-noble | ok 2025-04-18 03:15:29.538383 | 2025-04-18 03:15:29.538478 | TASK [emit-job-header : Print job information] 2025-04-18 03:15:29.619206 | # Job Information 2025-04-18 03:15:29.619354 | Ansible Version: 2.15.3 2025-04-18 03:15:29.619383 | Job: python-black 2025-04-18 03:15:29.619409 | Pipeline: periodic-daily 2025-04-18 03:15:29.619426 | Executor: 7d211f194f6a 2025-04-18 03:15:29.619442 | Triggered by: https://github.com/osism/testbed 2025-04-18 03:15:29.619458 | Event ID: 33edf45ed78a4fb8a49b62c7f13e43c6 2025-04-18 03:15:29.631838 | 2025-04-18 03:15:29.631933 | LOOP [emit-job-header : Print node information] 2025-04-18 03:15:29.835267 | ubuntu-noble | ok: 2025-04-18 03:15:29.835514 | ubuntu-noble | # Node Information 2025-04-18 03:15:29.835551 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-18 03:15:29.835575 | ubuntu-noble | Hostname: ubuntu 2025-04-18 03:15:29.835596 | ubuntu-noble | Username: zuul 2025-04-18 03:15:29.835615 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-18 03:15:29.835639 | ubuntu-noble | Provider: regiocloud-a 2025-04-18 03:15:29.835660 | ubuntu-noble | Label: ubuntu-noble 2025-04-18 03:15:29.835681 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-18 03:15:29.835700 | ubuntu-noble | Interface IP: 81.163.192.133 2025-04-18 03:15:29.850833 | 2025-04-18 03:15:29.850929 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-18 03:15:30.517856 | ubuntu-noble -> localhost | changed 2025-04-18 03:15:30.524859 | 2025-04-18 03:15:30.524963 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-18 03:15:31.558207 | ubuntu-noble -> localhost | changed 2025-04-18 03:15:31.572769 | 2025-04-18 03:15:31.572874 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-18 03:15:31.985797 | ubuntu-noble -> localhost | ok 2025-04-18 03:15:32.000592 | 2025-04-18 03:15:32.000709 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-18 03:15:32.054212 | ubuntu-noble | ok 2025-04-18 03:15:32.081223 | ubuntu-noble | included: /var/lib/zuul/builds/998d58cc86154a8f852e3efefef2399d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-18 03:15:32.098506 | 2025-04-18 03:15:32.098601 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-18 03:15:33.142252 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-18 03:15:33.142441 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/998d58cc86154a8f852e3efefef2399d/work/998d58cc86154a8f852e3efefef2399d_id_rsa 2025-04-18 03:15:33.142470 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/998d58cc86154a8f852e3efefef2399d/work/998d58cc86154a8f852e3efefef2399d_id_rsa.pub 2025-04-18 03:15:33.142490 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-18 03:15:33.142509 | ubuntu-noble -> localhost | SHA256:P9WWegLWMBcL2dA9sNsYu0xc6qH3MxI1meFNOiNGQkY zuul-build-sshkey 2025-04-18 03:15:33.142527 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-18 03:15:33.142543 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-18 03:15:33.142560 | ubuntu-noble -> localhost | | oE=oo | 2025-04-18 03:15:33.142575 | ubuntu-noble -> localhost | | .o.+++ .| 2025-04-18 03:15:33.142591 | ubuntu-noble -> localhost | | oo=..O | 2025-04-18 03:15:33.142616 | ubuntu-noble -> localhost | | *oXX..| 2025-04-18 03:15:33.142633 | ubuntu-noble -> localhost | | S o.@o=+ | 2025-04-18 03:15:33.142648 | ubuntu-noble -> localhost | | o B.= | 2025-04-18 03:15:33.142669 | ubuntu-noble -> localhost | | + B.. | 2025-04-18 03:15:33.142686 | ubuntu-noble -> localhost | | o.+o | 2025-04-18 03:15:33.142701 | ubuntu-noble -> localhost | | ..o | 2025-04-18 03:15:33.142717 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-18 03:15:33.142762 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.311309 2025-04-18 03:15:33.149582 | 2025-04-18 03:15:33.149669 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-18 03:15:33.202548 | ubuntu-noble | ok 2025-04-18 03:15:33.212466 | ubuntu-noble | included: /var/lib/zuul/builds/998d58cc86154a8f852e3efefef2399d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-18 03:15:33.221860 | 2025-04-18 03:15:33.221940 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-18 03:15:33.246839 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:15:33.253540 | 2025-04-18 03:15:33.253620 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-18 03:15:34.009802 | ubuntu-noble | changed 2025-04-18 03:15:34.022718 | 2025-04-18 03:15:34.022827 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-18 03:15:34.329006 | ubuntu-noble | ok 2025-04-18 03:15:34.349577 | 2025-04-18 03:15:34.349672 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-18 03:15:35.062198 | ubuntu-noble | changed 2025-04-18 03:15:35.078250 | 2025-04-18 03:15:35.078980 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-18 03:15:35.825167 | ubuntu-noble | changed 2025-04-18 03:15:35.831522 | 2025-04-18 03:15:35.831598 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-18 03:15:35.867405 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:15:35.873748 | 2025-04-18 03:15:35.873830 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-18 03:15:36.339017 | ubuntu-noble -> localhost | changed 2025-04-18 03:15:36.354764 | 2025-04-18 03:15:36.354859 | TASK [add-build-sshkey : Add back temp key] 2025-04-18 03:15:36.774890 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/998d58cc86154a8f852e3efefef2399d/work/998d58cc86154a8f852e3efefef2399d_id_rsa (zuul-build-sshkey) 2025-04-18 03:15:36.775062 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007522 2025-04-18 03:15:36.781355 | 2025-04-18 03:15:36.781437 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-18 03:15:37.414292 | ubuntu-noble | ok 2025-04-18 03:15:37.419848 | 2025-04-18 03:15:37.419922 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-18 03:15:37.479038 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:15:37.490696 | 2025-04-18 03:15:37.490787 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-18 03:15:37.977444 | ubuntu-noble | ok 2025-04-18 03:15:37.996011 | 2025-04-18 03:15:37.996125 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-18 03:15:38.040890 | ubuntu-noble | ok 2025-04-18 03:15:38.056119 | 2025-04-18 03:15:38.056234 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-18 03:15:38.342761 | ubuntu-noble -> localhost | ok 2025-04-18 03:15:38.350375 | 2025-04-18 03:15:38.350467 | TASK [validate-host : Collect information about the host] 2025-04-18 03:15:39.481418 | ubuntu-noble | ok 2025-04-18 03:15:39.493480 | 2025-04-18 03:15:39.493582 | TASK [validate-host : Sanitize hostname] 2025-04-18 03:15:39.553513 | ubuntu-noble | ok 2025-04-18 03:15:39.559940 | 2025-04-18 03:15:39.560032 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-18 03:15:40.106797 | ubuntu-noble -> localhost | changed 2025-04-18 03:15:40.113588 | 2025-04-18 03:15:40.113695 | TASK [validate-host : Collect information about zuul worker] 2025-04-18 03:15:40.657493 | ubuntu-noble | ok 2025-04-18 03:15:40.663389 | 2025-04-18 03:15:40.663482 | TASK [validate-host : Write out all zuul information for each host] 2025-04-18 03:15:41.248843 | ubuntu-noble -> localhost | changed 2025-04-18 03:15:41.260360 | 2025-04-18 03:15:41.260506 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-18 03:15:41.553968 | ubuntu-noble | ok 2025-04-18 03:15:41.559650 | 2025-04-18 03:15:41.559728 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-18 03:15:42.968845 | ubuntu-noble | changed: 2025-04-18 03:15:42.969044 | ubuntu-noble | cd+++++++++ src/ 2025-04-18 03:15:42.969088 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-18 03:15:42.969119 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-18 03:15:42.969146 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-18 03:15:42.969171 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.003851 2025-04-18 03:16:13.931644 | 2025-04-18 03:16:13.931724 | TASK [upload-logs : Upload logs to log server] 2025-04-18 03:16:14.482489 | localhost | Output suppressed because no_log was given 2025-04-18 03:16:14.484900 | 2025-04-18 03:16:14.484982 | LOOP [upload-logs : Compress console log and json output] 2025-04-18 03:16:14.565372 | localhost | skipping: Conditional result was False 2025-04-18 03:16:14.578928 | localhost | skipping: Conditional result was False 2025-04-18 03:16:14.582813 | 2025-04-18 03:16:14.582913 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-18 03:16:14.663700 | localhost | skipping: Conditional result was False 2025-04-18 03:16:14.663950 | 2025-04-18 03:16:14.664860 | localhost | skipping: Conditional result was False 2025-04-18 03:16:14.669012 | 2025-04-18 03:16:14.669107 | LOOP [upload-logs : Upload console log and json output]