2025-02-15 13:37:46.743553 | Job console starting... 2025-02-15 13:37:46.759736 | Updating repositories 2025-02-15 13:37:46.830661 | Preparing job workspace 2025-02-15 13:37:48.875903 | Running Ansible setup... 2025-02-15 13:37:54.705193 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-15 13:37:55.691237 | 2025-02-15 13:37:55.691407 | PLAY [Base pre] 2025-02-15 13:37:55.740057 | 2025-02-15 13:37:55.740269 | TASK [Setup log path fact] 2025-02-15 13:37:55.813439 | ubuntu-noble | ok 2025-02-15 13:37:55.855866 | 2025-02-15 13:37:55.868473 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-15 13:37:55.961484 | ubuntu-noble | ok 2025-02-15 13:37:55.972323 | 2025-02-15 13:37:55.972494 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-15 13:37:56.012714 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:37:56.020248 | 2025-02-15 13:37:56.020419 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-15 13:37:56.109411 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:37:56.120124 | 2025-02-15 13:37:56.120268 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-15 13:37:56.175433 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:37:56.182950 | 2025-02-15 13:37:56.183080 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-15 13:37:56.231672 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:37:56.239146 | 2025-02-15 13:37:56.239281 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-15 13:37:56.284047 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:37:56.303066 | 2025-02-15 13:37:56.303232 | TASK [emit-job-header : Print job information] 2025-02-15 13:37:56.355331 | # Job Information 2025-02-15 13:37:56.355606 | Ansible Version: 2.15.3 2025-02-15 13:37:56.355643 | Job: python-black 2025-02-15 13:37:56.355672 | Pipeline: check 2025-02-15 13:37:56.355692 | Executor: 7d211f194f6a 2025-02-15 13:37:56.355710 | Triggered by: https://github.com/osism/container-images-kolla/pull/550 2025-02-15 13:37:56.355728 | Event ID: 06049e50-eba2-11ef-8c85-9fdb3ca732db 2025-02-15 13:37:56.364715 | 2025-02-15 13:37:56.364852 | LOOP [emit-job-header : Print node information] 2025-02-15 13:37:56.536031 | ubuntu-noble | ok: 2025-02-15 13:37:56.536263 | ubuntu-noble | # Node Information 2025-02-15 13:37:56.536312 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-15 13:37:56.536343 | ubuntu-noble | Hostname: ubuntu 2025-02-15 13:37:56.536371 | ubuntu-noble | Username: zuul 2025-02-15 13:37:56.536415 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-15 13:37:56.536442 | ubuntu-noble | Provider: regiocloud-a 2025-02-15 13:37:56.536468 | ubuntu-noble | Label: ubuntu-noble 2025-02-15 13:37:56.536613 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-15 13:37:56.536643 | ubuntu-noble | Interface IP: 81.163.193.158 2025-02-15 13:37:56.550708 | 2025-02-15 13:37:56.550854 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-15 13:37:57.418627 | ubuntu-noble -> localhost | changed 2025-02-15 13:37:57.426511 | 2025-02-15 13:37:57.426617 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-15 13:37:58.968766 | ubuntu-noble -> localhost | changed 2025-02-15 13:37:58.982966 | 2025-02-15 13:37:58.983076 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-15 13:37:59.378993 | ubuntu-noble -> localhost | ok 2025-02-15 13:37:59.386070 | 2025-02-15 13:37:59.386194 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-15 13:37:59.424431 | ubuntu-noble | ok 2025-02-15 13:37:59.444521 | ubuntu-noble | included: /var/lib/zuul/builds/fb03238ec79e488fa94c75cf83993bf8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-15 13:37:59.452064 | 2025-02-15 13:37:59.452168 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-15 13:38:01.076261 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-15 13:38:01.076517 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb03238ec79e488fa94c75cf83993bf8/work/fb03238ec79e488fa94c75cf83993bf8_id_rsa 2025-02-15 13:38:01.076555 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb03238ec79e488fa94c75cf83993bf8/work/fb03238ec79e488fa94c75cf83993bf8_id_rsa.pub 2025-02-15 13:38:01.076579 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-15 13:38:01.076600 | ubuntu-noble -> localhost | SHA256:RXgvIRugPC64t73zOaO1io7m5zxst2p4Z+WyHEQhvBQ zuul-build-sshkey 2025-02-15 13:38:01.076621 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-15 13:38:01.076645 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-15 13:38:01.076667 | ubuntu-noble -> localhost | | .E.... .. | 2025-02-15 13:38:01.076686 | ubuntu-noble -> localhost | | +... +.o | 2025-02-15 13:38:01.076705 | ubuntu-noble -> localhost | | . =. =.o | 2025-02-15 13:38:01.076723 | ubuntu-noble -> localhost | | . o.. ... . | 2025-02-15 13:38:01.076742 | ubuntu-noble -> localhost | |. . .. S . | 2025-02-15 13:38:01.076760 | ubuntu-noble -> localhost | | . .. . | 2025-02-15 13:38:01.076779 | ubuntu-noble -> localhost | |. + .+ | 2025-02-15 13:38:01.076798 | ubuntu-noble -> localhost | | =.@o*++ | 2025-02-15 13:38:01.076817 | ubuntu-noble -> localhost | |+oX+@XBo | 2025-02-15 13:38:01.076836 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-15 13:38:01.076882 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.104716 2025-02-15 13:38:01.084080 | 2025-02-15 13:38:01.084179 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-15 13:38:01.123917 | ubuntu-noble | ok 2025-02-15 13:38:01.134736 | ubuntu-noble | included: /var/lib/zuul/builds/fb03238ec79e488fa94c75cf83993bf8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-15 13:38:01.144203 | 2025-02-15 13:38:01.144294 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-15 13:38:01.168307 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:38:01.175266 | 2025-02-15 13:38:01.175358 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-15 13:38:01.874580 | ubuntu-noble | changed 2025-02-15 13:38:01.881473 | 2025-02-15 13:38:01.881562 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-15 13:38:02.187166 | ubuntu-noble | ok 2025-02-15 13:38:02.196902 | 2025-02-15 13:38:02.197029 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-15 13:38:02.923129 | ubuntu-noble | changed 2025-02-15 13:38:02.931640 | 2025-02-15 13:38:02.931754 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-15 13:38:03.671808 | ubuntu-noble | changed 2025-02-15 13:38:03.680372 | 2025-02-15 13:38:03.680510 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-15 13:38:03.704475 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:38:03.711715 | 2025-02-15 13:38:03.711808 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-15 13:38:04.156786 | ubuntu-noble -> localhost | changed 2025-02-15 13:38:04.203888 | 2025-02-15 13:38:04.203995 | TASK [add-build-sshkey : Add back temp key] 2025-02-15 13:38:04.482067 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/fb03238ec79e488fa94c75cf83993bf8/work/fb03238ec79e488fa94c75cf83993bf8_id_rsa (zuul-build-sshkey) 2025-02-15 13:38:04.482271 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007000 2025-02-15 13:38:04.489354 | 2025-02-15 13:38:04.489445 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-15 13:38:04.904496 | ubuntu-noble | ok 2025-02-15 13:38:04.926869 | 2025-02-15 13:38:04.926987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-15 13:38:05.002240 | ubuntu-noble | skipping: Conditional result was False 2025-02-15 13:38:05.015256 | 2025-02-15 13:38:05.015363 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-15 13:38:05.528864 | ubuntu-noble | ok 2025-02-15 13:38:05.540753 | 2025-02-15 13:38:05.540860 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-15 13:38:05.570762 | ubuntu-noble | ok 2025-02-15 13:38:05.577157 | 2025-02-15 13:38:05.577253 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-15 13:38:05.834804 | ubuntu-noble -> localhost | ok 2025-02-15 13:38:05.850855 | 2025-02-15 13:38:05.850977 | TASK [validate-host : Collect information about the host] 2025-02-15 13:38:07.010011 | ubuntu-noble | ok 2025-02-15 13:38:07.022611 | 2025-02-15 13:38:07.022750 | TASK [validate-host : Sanitize hostname] 2025-02-15 13:38:07.094601 | ubuntu-noble | ok 2025-02-15 13:38:07.101522 | 2025-02-15 13:38:07.101662 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-15 13:38:07.720766 | ubuntu-noble -> localhost | changed 2025-02-15 13:38:07.728282 | 2025-02-15 13:38:07.728447 | TASK [validate-host : Collect information about zuul worker] 2025-02-15 13:38:08.358545 | ubuntu-noble | ok 2025-02-15 13:38:08.368908 | 2025-02-15 13:38:08.369049 | TASK [validate-host : Write out all zuul information for each host] 2025-02-15 13:38:09.024193 | ubuntu-noble -> localhost | changed 2025-02-15 13:38:09.037241 | 2025-02-15 13:38:09.040258 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-15 13:38:09.358144 | ubuntu-noble | ok 2025-02-15 13:38:09.369889 | 2025-02-15 13:38:09.370026 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-15 13:38:10.455280 | ubuntu-noble | changed: 2025-02-15 13:38:10.455477 | ubuntu-noble | cd+++++++++ src/ 2025-02-15 13:38:10.455510 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-15 13:38:10.455534 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-15 13:38:10.455556 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-images-kolla/ 2025-02-15 13:38:10.455576 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007710 2025-02-15 13:38:42.518063 | 2025-02-15 13:38:42.518302 | TASK [upload-logs : Upload logs to log server] 2025-02-15 13:38:43.167658 | localhost | Output suppressed because no_log was given 2025-02-15 13:38:43.179089 | 2025-02-15 13:38:43.179270 | LOOP [upload-logs : Compress console log and json output] 2025-02-15 13:38:43.302682 | localhost | skipping: Conditional result was False 2025-02-15 13:38:43.320871 | localhost | skipping: Conditional result was False 2025-02-15 13:38:43.335230 | 2025-02-15 13:38:43.335366 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-15 13:38:43.403117 | localhost | skipping: Conditional result was False 2025-02-15 13:38:43.403442 | 2025-02-15 13:38:43.417011 | localhost | skipping: Conditional result was False 2025-02-15 13:38:43.424738 | 2025-02-15 13:38:43.424863 | LOOP [upload-logs : Upload console log and json output]