2025-03-31 03:11:34.847771 | Job console starting... 2025-03-31 03:11:34.871112 | Updating repositories 2025-03-31 03:11:35.031117 | Preparing job workspace 2025-03-31 03:11:37.083490 | Running Ansible setup... 2025-03-31 03:11:44.731743 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-31 03:11:45.523959 | 2025-03-31 03:11:45.524067 | PLAY [Base pre] 2025-03-31 03:11:45.567385 | 2025-03-31 03:11:45.567540 | TASK [Setup log path fact] 2025-03-31 03:11:45.598622 | ubuntu-noble | ok 2025-03-31 03:11:45.635115 | 2025-03-31 03:11:45.635266 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-31 03:11:45.700035 | ubuntu-noble | ok 2025-03-31 03:11:45.722838 | 2025-03-31 03:11:45.722942 | TASK [emit-job-header : Print job information] 2025-03-31 03:11:45.786653 | # Job Information 2025-03-31 03:11:45.786860 | Ansible Version: 2.15.3 2025-03-31 03:11:45.786892 | Job: python-black 2025-03-31 03:11:45.786920 | Pipeline: periodic-daily 2025-03-31 03:11:45.786941 | Executor: 7d211f194f6a 2025-03-31 03:11:45.786957 | Triggered by: https://github.com/osism/rookify 2025-03-31 03:11:45.786972 | Event ID: 32430b6f20a4487bbd54f0eee04e3d9c 2025-03-31 03:11:45.806149 | 2025-03-31 03:11:45.806274 | LOOP [emit-job-header : Print node information] 2025-03-31 03:11:45.952213 | ubuntu-noble | ok: 2025-03-31 03:11:45.952351 | ubuntu-noble | # Node Information 2025-03-31 03:11:45.952378 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-31 03:11:45.954557 | ubuntu-noble | Hostname: ubuntu 2025-03-31 03:11:45.954593 | ubuntu-noble | Username: zuul 2025-03-31 03:11:45.954614 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-31 03:11:45.954636 | ubuntu-noble | Provider: regiocloud-a 2025-03-31 03:11:45.954653 | ubuntu-noble | Label: ubuntu-noble 2025-03-31 03:11:45.954670 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-31 03:11:45.954688 | ubuntu-noble | Interface IP: 81.163.193.181 2025-03-31 03:11:45.980092 | 2025-03-31 03:11:45.980213 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-31 03:11:46.931999 | ubuntu-noble -> localhost | changed 2025-03-31 03:11:46.939065 | 2025-03-31 03:11:46.939144 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-31 03:11:48.126910 | ubuntu-noble -> localhost | changed 2025-03-31 03:11:48.140826 | 2025-03-31 03:11:48.141716 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-31 03:11:48.457595 | ubuntu-noble -> localhost | ok 2025-03-31 03:11:48.474539 | 2025-03-31 03:11:48.474646 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-31 03:11:48.523728 | ubuntu-noble | ok 2025-03-31 03:11:48.554428 | ubuntu-noble | included: /var/lib/zuul/builds/2467260cd45a42ccb03ac3b75a214202/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-31 03:11:48.561041 | 2025-03-31 03:11:48.561129 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-31 03:11:49.457613 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-31 03:11:49.457777 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/2467260cd45a42ccb03ac3b75a214202/work/2467260cd45a42ccb03ac3b75a214202_id_rsa 2025-03-31 03:11:49.457805 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/2467260cd45a42ccb03ac3b75a214202/work/2467260cd45a42ccb03ac3b75a214202_id_rsa.pub 2025-03-31 03:11:49.457826 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-31 03:11:49.457845 | ubuntu-noble -> localhost | SHA256:3/s+vBinYzZdHK6DtsXNdkuzzHI+dAzu7D85jMbE/nc zuul-build-sshkey 2025-03-31 03:11:49.457863 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-31 03:11:49.457881 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-31 03:11:49.457898 | ubuntu-noble -> localhost | | | 2025-03-31 03:11:49.457914 | ubuntu-noble -> localhost | | | 2025-03-31 03:11:49.457930 | ubuntu-noble -> localhost | | | 2025-03-31 03:11:49.457956 | ubuntu-noble -> localhost | | .. | 2025-03-31 03:11:49.457974 | ubuntu-noble -> localhost | | S ...+.| 2025-03-31 03:11:49.457990 | ubuntu-noble -> localhost | | . ..o+o=| 2025-03-31 03:11:49.458011 | ubuntu-noble -> localhost | | . BB*B+| 2025-03-31 03:11:49.458029 | ubuntu-noble -> localhost | | o*#@BE| 2025-03-31 03:11:49.458046 | ubuntu-noble -> localhost | | .+**@@B| 2025-03-31 03:11:49.458063 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-31 03:11:49.458102 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.304201 2025-03-31 03:11:49.464033 | 2025-03-31 03:11:49.464109 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-31 03:11:49.490176 | ubuntu-noble | ok 2025-03-31 03:11:49.504860 | ubuntu-noble | included: /var/lib/zuul/builds/2467260cd45a42ccb03ac3b75a214202/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-31 03:11:49.517145 | 2025-03-31 03:11:49.517237 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-31 03:11:49.541347 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 03:11:49.547178 | 2025-03-31 03:11:49.547279 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-31 03:11:50.234455 | ubuntu-noble | changed 2025-03-31 03:11:50.241104 | 2025-03-31 03:11:50.241218 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-31 03:11:50.524418 | ubuntu-noble | ok 2025-03-31 03:11:50.532113 | 2025-03-31 03:11:50.532217 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-31 03:11:51.160504 | ubuntu-noble | changed 2025-03-31 03:11:51.167132 | 2025-03-31 03:11:51.167224 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-31 03:11:51.843757 | ubuntu-noble | changed 2025-03-31 03:11:51.850540 | 2025-03-31 03:11:51.850630 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-31 03:11:51.874730 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 03:11:51.881679 | 2025-03-31 03:11:51.881771 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-31 03:11:52.257483 | ubuntu-noble -> localhost | changed 2025-03-31 03:11:52.275746 | 2025-03-31 03:11:52.275849 | TASK [add-build-sshkey : Add back temp key] 2025-03-31 03:11:52.738873 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/2467260cd45a42ccb03ac3b75a214202/work/2467260cd45a42ccb03ac3b75a214202_id_rsa (zuul-build-sshkey) 2025-03-31 03:11:52.739046 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.021643 2025-03-31 03:11:52.745348 | 2025-03-31 03:11:52.745443 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-31 03:11:53.120214 | ubuntu-noble | ok 2025-03-31 03:11:53.125776 | 2025-03-31 03:11:53.125864 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-31 03:11:53.182242 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 03:11:53.193906 | 2025-03-31 03:11:53.193988 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-31 03:11:53.687345 | ubuntu-noble | ok 2025-03-31 03:11:53.702689 | 2025-03-31 03:11:53.702782 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-31 03:11:53.737289 | ubuntu-noble | ok 2025-03-31 03:11:53.749078 | 2025-03-31 03:11:53.749201 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-31 03:11:54.134946 | ubuntu-noble -> localhost | ok 2025-03-31 03:11:54.142691 | 2025-03-31 03:11:54.142779 | TASK [validate-host : Collect information about the host] 2025-03-31 03:11:55.483212 | ubuntu-noble | ok 2025-03-31 03:11:55.501760 | 2025-03-31 03:11:55.501865 | TASK [validate-host : Sanitize hostname] 2025-03-31 03:11:55.615691 | ubuntu-noble | ok 2025-03-31 03:11:55.624959 | 2025-03-31 03:11:55.625059 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-31 03:11:56.508131 | ubuntu-noble -> localhost | changed 2025-03-31 03:11:56.515475 | 2025-03-31 03:11:56.515577 | TASK [validate-host : Collect information about zuul worker] 2025-03-31 03:11:57.055453 | ubuntu-noble | ok 2025-03-31 03:11:57.063840 | 2025-03-31 03:11:57.063944 | TASK [validate-host : Write out all zuul information for each host] 2025-03-31 03:11:58.095543 | ubuntu-noble -> localhost | changed 2025-03-31 03:11:58.126155 | 2025-03-31 03:11:58.126288 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-31 03:11:58.456424 | ubuntu-noble | ok 2025-03-31 03:11:58.468695 | 2025-03-31 03:11:58.468794 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-31 03:11:59.613095 | ubuntu-noble | changed: 2025-03-31 03:11:59.613253 | ubuntu-noble | cd+++++++++ src/ 2025-03-31 03:11:59.613284 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-31 03:11:59.613305 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-31 03:11:59.613323 | ubuntu-noble | cd+++++++++ src/github.com/osism/rookify/ 2025-03-31 03:11:59.613340 | ubuntu-noble | Containerfile 2025-03-31 03:11:59.613462 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009014 2025-03-31 03:12:37.733918 | 2025-03-31 03:12:37.734014 | TASK [upload-logs : Upload logs to log server] 2025-03-31 03:12:38.904410 | localhost | Output suppressed because no_log was given 2025-03-31 03:12:38.907579 | 2025-03-31 03:12:38.907664 | LOOP [upload-logs : Compress console log and json output] 2025-03-31 03:12:39.041747 | localhost | skipping: Conditional result was False 2025-03-31 03:12:39.045002 | localhost | skipping: Conditional result was False 2025-03-31 03:12:39.055452 | 2025-03-31 03:12:39.055537 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-31 03:12:39.167005 | localhost | skipping: Conditional result was False 2025-03-31 03:12:39.167356 | 2025-03-31 03:12:39.195835 | localhost | skipping: Conditional result was False 2025-03-31 03:12:39.205570 | 2025-03-31 03:12:39.205670 | LOOP [upload-logs : Upload console log and json output]