2025-05-09 04:48:31.777876 | Job console starting... 2025-05-09 04:48:31.789767 | Updating repositories 2025-05-09 04:53:47.121170 | Preparing job workspace 2025-05-09 04:53:49.876365 | Running Ansible setup... 2025-05-09 04:53:58.422726 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-09 04:54:00.647112 | 2025-05-09 04:54:00.647255 | PLAY [Base pre] 2025-05-09 04:54:00.737614 | 2025-05-09 04:54:00.737751 | TASK [Setup log path fact] 2025-05-09 04:54:00.775474 | ubuntu-noble | ok 2025-05-09 04:54:00.836644 | 2025-05-09 04:54:00.836779 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-09 04:54:00.897797 | ubuntu-noble | ok 2025-05-09 04:54:00.931942 | 2025-05-09 04:54:00.932063 | TASK [emit-job-header : Print job information] 2025-05-09 04:54:01.066641 | # Job Information 2025-05-09 04:54:01.066789 | Ansible Version: 2.15.3 2025-05-09 04:54:01.066821 | Job: python-black 2025-05-09 04:54:01.066883 | Pipeline: periodic-daily 2025-05-09 04:54:01.066915 | Executor: 7d211f194f6a 2025-05-09 04:54:01.066935 | Triggered by: https://github.com/osism/rookify 2025-05-09 04:54:01.066955 | Event ID: 1db91285ab174aeebcc0fa78477a7676 2025-05-09 04:54:01.078471 | 2025-05-09 04:54:01.078590 | LOOP [emit-job-header : Print node information] 2025-05-09 04:54:01.416625 | ubuntu-noble | ok: 2025-05-09 04:54:01.417800 | ubuntu-noble | # Node Information 2025-05-09 04:54:01.418138 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-09 04:54:01.418179 | ubuntu-noble | Hostname: ubuntu 2025-05-09 04:54:01.418229 | ubuntu-noble | Username: zuul 2025-05-09 04:54:01.418256 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-09 04:54:01.418557 | ubuntu-noble | Provider: regiocloud-a 2025-05-09 04:54:01.418949 | ubuntu-noble | Region: 2025-05-09 04:54:01.419152 | ubuntu-noble | Label: ubuntu-noble 2025-05-09 04:54:01.419454 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-09 04:54:01.419598 | ubuntu-noble | Interface IP: 81.163.193.235 2025-05-09 04:54:01.472642 | 2025-05-09 04:54:01.473164 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-09 04:54:03.275786 | ubuntu-noble -> localhost | changed 2025-05-09 04:54:03.288645 | 2025-05-09 04:54:03.288937 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-09 04:54:06.948171 | ubuntu-noble -> localhost | changed 2025-05-09 04:54:06.974246 | 2025-05-09 04:54:06.974346 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-09 04:54:08.073887 | ubuntu-noble -> localhost | ok 2025-05-09 04:54:08.080442 | 2025-05-09 04:54:08.080533 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-09 04:54:08.119370 | ubuntu-noble | ok 2025-05-09 04:54:08.198763 | ubuntu-noble | included: /var/lib/zuul/builds/a8d1c134114f4ec7a273aaa1e730417e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-09 04:54:08.241978 | 2025-05-09 04:54:08.242075 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-09 04:54:09.813175 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-09 04:54:09.813337 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8d1c134114f4ec7a273aaa1e730417e/work/a8d1c134114f4ec7a273aaa1e730417e_id_rsa 2025-05-09 04:54:09.813366 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8d1c134114f4ec7a273aaa1e730417e/work/a8d1c134114f4ec7a273aaa1e730417e_id_rsa.pub 2025-05-09 04:54:09.813387 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-09 04:54:09.813406 | ubuntu-noble -> localhost | SHA256:yHaSVH3kyUXG03gEpBwGr5PG1DwHcimqknYqxUJzSnc zuul-build-sshkey 2025-05-09 04:54:09.813424 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-09 04:54:09.813441 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-09 04:54:09.813458 | ubuntu-noble -> localhost | | ..oo*=*=.| 2025-05-09 04:54:09.813474 | ubuntu-noble -> localhost | | . o@oB+ o| 2025-05-09 04:54:09.813489 | ubuntu-noble -> localhost | | . ..o@ .o | 2025-05-09 04:54:09.813516 | ubuntu-noble -> localhost | | + ooEo.o o o | 2025-05-09 04:54:09.813533 | ubuntu-noble -> localhost | | o * o*.S * | 2025-05-09 04:54:09.813555 | ubuntu-noble -> localhost | | o *.oo . . | 2025-05-09 04:54:09.813571 | ubuntu-noble -> localhost | | + + | 2025-05-09 04:54:09.813587 | ubuntu-noble -> localhost | | . . | 2025-05-09 04:54:09.813603 | ubuntu-noble -> localhost | | . | 2025-05-09 04:54:09.813619 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-09 04:54:09.813660 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.163765 2025-05-09 04:54:09.820118 | 2025-05-09 04:54:09.820201 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-09 04:54:09.879884 | ubuntu-noble | ok 2025-05-09 04:54:09.901292 | ubuntu-noble | included: /var/lib/zuul/builds/a8d1c134114f4ec7a273aaa1e730417e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-09 04:54:09.933185 | 2025-05-09 04:54:09.933286 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-09 04:54:09.989545 | ubuntu-noble | skipping: Conditional result was False 2025-05-09 04:54:09.996800 | 2025-05-09 04:54:09.996926 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-09 04:54:11.308432 | ubuntu-noble | changed 2025-05-09 04:54:11.319510 | 2025-05-09 04:54:11.319612 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-09 04:54:11.663526 | ubuntu-noble | ok 2025-05-09 04:54:11.688222 | 2025-05-09 04:54:11.689331 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-09 04:54:12.620127 | ubuntu-noble | changed 2025-05-09 04:54:12.627857 | 2025-05-09 04:54:12.627984 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-09 04:54:13.502605 | ubuntu-noble | changed 2025-05-09 04:54:13.570387 | 2025-05-09 04:54:13.570477 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-09 04:54:13.651502 | ubuntu-noble | skipping: Conditional result was False 2025-05-09 04:54:13.658689 | 2025-05-09 04:54:13.658793 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-09 04:54:14.865156 | ubuntu-noble -> localhost | changed 2025-05-09 04:54:14.898197 | 2025-05-09 04:54:14.898312 | TASK [add-build-sshkey : Add back temp key] 2025-05-09 04:54:15.840796 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a8d1c134114f4ec7a273aaa1e730417e/work/a8d1c134114f4ec7a273aaa1e730417e_id_rsa (zuul-build-sshkey) 2025-05-09 04:54:15.841000 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.029551 2025-05-09 04:54:15.848108 | 2025-05-09 04:54:15.848210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-09 04:54:16.523609 | ubuntu-noble | ok 2025-05-09 04:54:16.530056 | 2025-05-09 04:54:16.530157 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-09 04:54:16.624178 | ubuntu-noble | skipping: Conditional result was False 2025-05-09 04:54:16.649529 | 2025-05-09 04:54:16.649641 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-09 04:54:17.383994 | ubuntu-noble | ok 2025-05-09 04:54:17.413314 | 2025-05-09 04:54:17.413414 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-09 04:54:17.468139 | ubuntu-noble | ok 2025-05-09 04:54:17.478747 | 2025-05-09 04:54:17.478854 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-09 04:54:18.428105 | ubuntu-noble -> localhost | ok 2025-05-09 04:54:18.434708 | 2025-05-09 04:54:18.434797 | TASK [validate-host : Collect information about the host] 2025-05-09 04:54:19.928022 | ubuntu-noble | ok 2025-05-09 04:54:19.961388 | 2025-05-09 04:54:19.961491 | TASK [validate-host : Sanitize hostname] 2025-05-09 04:54:20.147786 | ubuntu-noble | ok 2025-05-09 04:54:20.154436 | 2025-05-09 04:54:20.154519 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-09 04:54:21.436060 | ubuntu-noble -> localhost | changed 2025-05-09 04:54:21.442084 | 2025-05-09 04:54:21.442164 | TASK [validate-host : Collect information about zuul worker] 2025-05-09 04:54:22.502824 | ubuntu-noble | ok 2025-05-09 04:54:22.509341 | 2025-05-09 04:54:22.509433 | TASK [validate-host : Write out all zuul information for each host] 2025-05-09 04:54:24.583659 | ubuntu-noble -> localhost | changed 2025-05-09 04:54:24.608490 | 2025-05-09 04:54:24.608593 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-09 04:54:25.035328 | ubuntu-noble | ok 2025-05-09 04:54:25.056992 | 2025-05-09 04:54:25.057092 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-09 04:54:26.957695 | ubuntu-noble | changed: 2025-05-09 04:54:26.958316 | ubuntu-noble | cd+++++++++ src/ 2025-05-09 04:54:26.958371 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-09 04:54:26.958393 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-09 04:54:26.958412 | ubuntu-noble | cd+++++++++ src/github.com/osism/rookify/ 2025-05-09 04:54:26.958429 | ubuntu-noble | Containerfile 2025-05-09 04:54:26.958553 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.030471 2025-05-09 04:55:11.484646 | 2025-05-09 04:55:11.484727 | TASK [upload-logs : Upload logs to log server] 2025-05-09 04:55:13.452341 | localhost | Output suppressed because no_log was given 2025-05-09 04:55:13.454766 | 2025-05-09 04:55:13.455087 | LOOP [upload-logs : Compress console log and json output] 2025-05-09 04:55:13.625436 | localhost | skipping: Conditional result was False 2025-05-09 04:55:13.635703 | localhost | skipping: Conditional result was False 2025-05-09 04:55:13.641875 | 2025-05-09 04:55:13.641980 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-09 04:55:13.958892 | localhost | skipping: Conditional result was False 2025-05-09 04:55:13.959134 | 2025-05-09 04:55:13.969659 | localhost | skipping: Conditional result was False 2025-05-09 04:55:13.975286 | 2025-05-09 04:55:13.975373 | LOOP [upload-logs : Upload console log and json output]