2025-04-30 03:01:50.390642 | Job console starting... 2025-04-30 03:01:50.410611 | Updating repositories 2025-04-30 03:01:51.132118 | Preparing job workspace 2025-04-30 03:01:54.144824 | Running Ansible setup... 2025-04-30 03:02:01.396811 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-30 03:02:02.846895 | 2025-04-30 03:02:02.847054 | PLAY [Base pre] 2025-04-30 03:02:02.879368 | 2025-04-30 03:02:02.879481 | TASK [Setup log path fact] 2025-04-30 03:02:02.941803 | ubuntu-noble | ok 2025-04-30 03:02:03.000659 | 2025-04-30 03:02:03.000811 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-30 03:02:03.061829 | ubuntu-noble | ok 2025-04-30 03:02:03.096522 | 2025-04-30 03:02:03.096698 | TASK [emit-job-header : Print job information] 2025-04-30 03:02:03.233380 | # Job Information 2025-04-30 03:02:03.233536 | Ansible Version: 2.15.3 2025-04-30 03:02:03.233568 | Job: python-black 2025-04-30 03:02:03.233597 | Pipeline: periodic-daily 2025-04-30 03:02:03.233617 | Executor: 7d211f194f6a 2025-04-30 03:02:03.233636 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-04-30 03:02:03.233654 | Event ID: 88001b0f882a447ca781c1e8a7b40759 2025-04-30 03:02:03.247478 | 2025-04-30 03:02:03.247584 | LOOP [emit-job-header : Print node information] 2025-04-30 03:02:03.473057 | ubuntu-noble | ok: 2025-04-30 03:02:03.473214 | ubuntu-noble | # Node Information 2025-04-30 03:02:03.473246 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-30 03:02:03.473269 | ubuntu-noble | Hostname: ubuntu 2025-04-30 03:02:03.473290 | ubuntu-noble | Username: zuul 2025-04-30 03:02:03.473310 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-30 03:02:03.473333 | ubuntu-noble | Provider: regiocloud-a 2025-04-30 03:02:03.473353 | ubuntu-noble | Label: ubuntu-noble 2025-04-30 03:02:03.473373 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-30 03:02:03.473393 | ubuntu-noble | Interface IP: 81.163.192.162 2025-04-30 03:02:03.494626 | 2025-04-30 03:02:03.494745 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-30 03:02:04.279858 | ubuntu-noble -> localhost | changed 2025-04-30 03:02:04.288087 | 2025-04-30 03:02:04.288190 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-30 03:02:06.347157 | ubuntu-noble -> localhost | changed 2025-04-30 03:02:06.360364 | 2025-04-30 03:02:06.360483 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-30 03:02:06.859226 | ubuntu-noble -> localhost | ok 2025-04-30 03:02:06.893327 | 2025-04-30 03:02:06.893424 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-30 03:02:06.956609 | ubuntu-noble | ok 2025-04-30 03:02:06.975172 | ubuntu-noble | included: /var/lib/zuul/builds/74e6fcf9a1ba4c8f87c72eb9e28731da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-30 03:02:06.982908 | 2025-04-30 03:02:06.983006 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-30 03:02:08.147681 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-30 03:02:08.147841 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/74e6fcf9a1ba4c8f87c72eb9e28731da/work/74e6fcf9a1ba4c8f87c72eb9e28731da_id_rsa 2025-04-30 03:02:08.147870 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/74e6fcf9a1ba4c8f87c72eb9e28731da/work/74e6fcf9a1ba4c8f87c72eb9e28731da_id_rsa.pub 2025-04-30 03:02:08.147892 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-30 03:02:08.147912 | ubuntu-noble -> localhost | SHA256:ddHFuqfVPjh4CGR4FYFHx0BN+QazX5FPOST/ZP0fj9k zuul-build-sshkey 2025-04-30 03:02:08.147932 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-30 03:02:08.147950 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-30 03:02:08.147978 | ubuntu-noble -> localhost | | +*O=o++| 2025-04-30 03:02:08.147996 | ubuntu-noble -> localhost | | . o.B+=+| 2025-04-30 03:02:08.148013 | ubuntu-noble -> localhost | | . + . =+B| 2025-04-30 03:02:08.148038 | ubuntu-noble -> localhost | | . = . ..==| 2025-04-30 03:02:08.148056 | ubuntu-noble -> localhost | | S oo=| 2025-04-30 03:02:08.148072 | ubuntu-noble -> localhost | | . .=B| 2025-04-30 03:02:08.148093 | ubuntu-noble -> localhost | | . o +=E| 2025-04-30 03:02:08.148110 | ubuntu-noble -> localhost | | o +...| 2025-04-30 03:02:08.148126 | ubuntu-noble -> localhost | | . . .| 2025-04-30 03:02:08.148142 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-30 03:02:08.148183 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.305252 2025-04-30 03:02:08.154586 | 2025-04-30 03:02:08.154669 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-30 03:02:08.223916 | ubuntu-noble | ok 2025-04-30 03:02:08.245062 | ubuntu-noble | included: /var/lib/zuul/builds/74e6fcf9a1ba4c8f87c72eb9e28731da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-30 03:02:08.252959 | 2025-04-30 03:02:08.253061 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-30 03:02:08.307309 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:02:08.313668 | 2025-04-30 03:02:08.313750 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-30 03:02:09.113070 | ubuntu-noble | changed 2025-04-30 03:02:09.124741 | 2025-04-30 03:02:09.124840 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-30 03:02:09.410631 | ubuntu-noble | ok 2025-04-30 03:02:09.419848 | 2025-04-30 03:02:09.419948 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-30 03:02:10.199901 | ubuntu-noble | changed 2025-04-30 03:02:10.215525 | 2025-04-30 03:02:10.217440 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-30 03:02:11.054630 | ubuntu-noble | changed 2025-04-30 03:02:11.073302 | 2025-04-30 03:02:11.073408 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-30 03:02:11.100609 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:02:11.108319 | 2025-04-30 03:02:11.108424 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-30 03:02:12.348302 | ubuntu-noble -> localhost | changed 2025-04-30 03:02:12.373385 | 2025-04-30 03:02:12.373916 | TASK [add-build-sshkey : Add back temp key] 2025-04-30 03:02:13.077032 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/74e6fcf9a1ba4c8f87c72eb9e28731da/work/74e6fcf9a1ba4c8f87c72eb9e28731da_id_rsa (zuul-build-sshkey) 2025-04-30 03:02:13.077232 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.019208 2025-04-30 03:02:13.168602 | 2025-04-30 03:02:13.168716 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-30 03:02:13.822319 | ubuntu-noble | ok 2025-04-30 03:02:13.830278 | 2025-04-30 03:02:13.830359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-30 03:02:13.898733 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:02:13.914387 | 2025-04-30 03:02:13.914483 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-30 03:02:14.426686 | ubuntu-noble | ok 2025-04-30 03:02:14.449724 | 2025-04-30 03:02:14.449819 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-30 03:02:14.479778 | ubuntu-noble | ok 2025-04-30 03:02:14.496927 | 2025-04-30 03:02:14.497045 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-30 03:02:14.936804 | ubuntu-noble -> localhost | ok 2025-04-30 03:02:14.943580 | 2025-04-30 03:02:14.943666 | TASK [validate-host : Collect information about the host] 2025-04-30 03:02:16.225262 | ubuntu-noble | ok 2025-04-30 03:02:16.246691 | 2025-04-30 03:02:16.246788 | TASK [validate-host : Sanitize hostname] 2025-04-30 03:02:16.383802 | ubuntu-noble | ok 2025-04-30 03:02:16.394588 | 2025-04-30 03:02:16.394679 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-30 03:02:17.028559 | ubuntu-noble -> localhost | changed 2025-04-30 03:02:17.036365 | 2025-04-30 03:02:17.036488 | TASK [validate-host : Collect information about zuul worker] 2025-04-30 03:02:17.643975 | ubuntu-noble | ok 2025-04-30 03:02:17.654139 | 2025-04-30 03:02:17.654238 | TASK [validate-host : Write out all zuul information for each host] 2025-04-30 03:02:18.775636 | ubuntu-noble -> localhost | changed 2025-04-30 03:02:18.793783 | 2025-04-30 03:02:18.793905 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-30 03:02:19.127559 | ubuntu-noble | ok 2025-04-30 03:02:19.146617 | 2025-04-30 03:02:19.146742 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-30 03:02:20.384213 | ubuntu-noble | changed: 2025-04-30 03:02:20.384451 | ubuntu-noble | cd+++++++++ src/ 2025-04-30 03:02:20.384493 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-30 03:02:20.384518 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-30 03:02:20.384540 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-04-30 03:02:20.384561 | ubuntu-noble | Containerfile 2025-04-30 03:02:20.384695 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.058152 2025-04-30 03:02:57.450154 | 2025-04-30 03:02:57.450242 | TASK [upload-logs : Upload logs to log server] 2025-04-30 03:02:58.620233 | localhost | Output suppressed because no_log was given 2025-04-30 03:02:58.628253 | 2025-04-30 03:02:58.628338 | LOOP [upload-logs : Compress console log and json output] 2025-04-30 03:02:58.737354 | localhost | skipping: Conditional result was False 2025-04-30 03:02:58.738245 | localhost | skipping: Conditional result was False 2025-04-30 03:02:58.746738 | 2025-04-30 03:02:58.746848 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-30 03:02:58.810584 | localhost | skipping: Conditional result was False 2025-04-30 03:02:58.810860 | 2025-04-30 03:02:58.811527 | localhost | skipping: Conditional result was False 2025-04-30 03:02:58.819135 | 2025-04-30 03:02:58.819234 | LOOP [upload-logs : Upload console log and json output]