2025-04-19 03:09:27.511383 | Job console starting... 2025-04-19 03:09:27.522544 | Updating repositories 2025-04-19 03:09:27.577443 | Preparing job workspace 2025-04-19 03:09:28.895644 | Running Ansible setup... 2025-04-19 03:09:34.170836 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-19 03:09:34.815708 | 2025-04-19 03:09:34.815820 | PLAY [Base pre] 2025-04-19 03:09:34.839371 | 2025-04-19 03:09:34.839476 | TASK [Setup log path fact] 2025-04-19 03:09:34.892305 | ubuntu-noble | ok 2025-04-19 03:09:34.911690 | 2025-04-19 03:09:34.911803 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-19 03:09:34.940458 | ubuntu-noble | ok 2025-04-19 03:09:34.951318 | 2025-04-19 03:09:34.951404 | TASK [emit-job-header : Print job information] 2025-04-19 03:09:35.008357 | # Job Information 2025-04-19 03:09:35.008613 | Ansible Version: 2.15.3 2025-04-19 03:09:35.008665 | Job: python-black 2025-04-19 03:09:35.008711 | Pipeline: periodic-daily 2025-04-19 03:09:35.008742 | Executor: 7d211f194f6a 2025-04-19 03:09:35.008771 | Triggered by: https://github.com/osism/rookify 2025-04-19 03:09:35.008799 | Event ID: ee392bb9781a4947b17fa5267a67babb 2025-04-19 03:09:35.017800 | 2025-04-19 03:09:35.017920 | LOOP [emit-job-header : Print node information] 2025-04-19 03:09:35.167858 | ubuntu-noble | ok: 2025-04-19 03:09:35.168101 | ubuntu-noble | # Node Information 2025-04-19 03:09:35.168138 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-19 03:09:35.168162 | ubuntu-noble | Hostname: ubuntu 2025-04-19 03:09:35.168183 | ubuntu-noble | Username: zuul 2025-04-19 03:09:35.168203 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-19 03:09:35.168226 | ubuntu-noble | Provider: regiocloud-a 2025-04-19 03:09:35.168247 | ubuntu-noble | Label: ubuntu-noble 2025-04-19 03:09:35.168267 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-19 03:09:35.168287 | ubuntu-noble | Interface IP: 81.163.192.157 2025-04-19 03:09:35.187268 | 2025-04-19 03:09:35.187366 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-19 03:09:35.599200 | ubuntu-noble -> localhost | changed 2025-04-19 03:09:35.606234 | 2025-04-19 03:09:35.606424 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-19 03:09:36.561403 | ubuntu-noble -> localhost | changed 2025-04-19 03:09:36.579343 | 2025-04-19 03:09:36.579455 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-19 03:09:36.904476 | ubuntu-noble -> localhost | ok 2025-04-19 03:09:36.912004 | 2025-04-19 03:09:36.912121 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-19 03:09:36.942799 | ubuntu-noble | ok 2025-04-19 03:09:36.958778 | ubuntu-noble | included: /var/lib/zuul/builds/8090021ac1ed461f904b2e008dd9d254/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-19 03:09:36.966755 | 2025-04-19 03:09:36.966876 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-19 03:09:37.838665 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-19 03:09:37.838842 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/8090021ac1ed461f904b2e008dd9d254/work/8090021ac1ed461f904b2e008dd9d254_id_rsa 2025-04-19 03:09:37.838883 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/8090021ac1ed461f904b2e008dd9d254/work/8090021ac1ed461f904b2e008dd9d254_id_rsa.pub 2025-04-19 03:09:37.838904 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-19 03:09:37.838923 | ubuntu-noble -> localhost | SHA256:874O2pFEhY2P9PR7chsZXJGVOgzM+W2Gxzg/MEiL0Cg zuul-build-sshkey 2025-04-19 03:09:37.838940 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-19 03:09:37.838957 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-19 03:09:37.838973 | ubuntu-noble -> localhost | | o++ . .*| 2025-04-19 03:09:37.838989 | ubuntu-noble -> localhost | | E o+oo* o.| 2025-04-19 03:09:37.839005 | ubuntu-noble -> localhost | | ..o=o.*.*. | 2025-04-19 03:09:37.839028 | ubuntu-noble -> localhost | | ...oo.@o* | 2025-04-19 03:09:37.839044 | ubuntu-noble -> localhost | | S .Xo | 2025-04-19 03:09:37.839059 | ubuntu-noble -> localhost | | . + o =o | 2025-04-19 03:09:37.839080 | ubuntu-noble -> localhost | | + . + o.| 2025-04-19 03:09:37.839097 | ubuntu-noble -> localhost | | o + . | 2025-04-19 03:09:37.839112 | ubuntu-noble -> localhost | | . ..+. | 2025-04-19 03:09:37.839128 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-19 03:09:37.839169 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.320742 2025-04-19 03:09:37.845957 | 2025-04-19 03:09:37.846036 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-19 03:09:37.874426 | ubuntu-noble | ok 2025-04-19 03:09:37.883373 | ubuntu-noble | included: /var/lib/zuul/builds/8090021ac1ed461f904b2e008dd9d254/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-19 03:09:37.891369 | 2025-04-19 03:09:37.891445 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-19 03:09:37.905299 | ubuntu-noble | skipping: Conditional result was False 2025-04-19 03:09:37.912338 | 2025-04-19 03:09:37.912453 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-19 03:09:38.761653 | ubuntu-noble | changed 2025-04-19 03:09:38.772086 | 2025-04-19 03:09:38.772172 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-19 03:09:39.076252 | ubuntu-noble | ok 2025-04-19 03:09:39.082069 | 2025-04-19 03:09:39.082145 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-19 03:09:39.797220 | ubuntu-noble | changed 2025-04-19 03:09:39.806620 | 2025-04-19 03:09:39.806749 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-19 03:09:40.502222 | ubuntu-noble | changed 2025-04-19 03:09:40.515788 | 2025-04-19 03:09:40.515893 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-19 03:09:40.543621 | ubuntu-noble | skipping: Conditional result was False 2025-04-19 03:09:40.550746 | 2025-04-19 03:09:40.550846 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-19 03:09:40.963574 | ubuntu-noble -> localhost | changed 2025-04-19 03:09:40.976819 | 2025-04-19 03:09:40.976923 | TASK [add-build-sshkey : Add back temp key] 2025-04-19 03:09:41.277365 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/8090021ac1ed461f904b2e008dd9d254/work/8090021ac1ed461f904b2e008dd9d254_id_rsa (zuul-build-sshkey) 2025-04-19 03:09:41.277806 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013717 2025-04-19 03:09:41.288702 | 2025-04-19 03:09:41.288785 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-19 03:09:41.676806 | ubuntu-noble | ok 2025-04-19 03:09:41.684908 | 2025-04-19 03:09:41.685013 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-19 03:09:41.708705 | ubuntu-noble | skipping: Conditional result was False 2025-04-19 03:09:41.727612 | 2025-04-19 03:09:41.727696 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-19 03:09:42.165503 | ubuntu-noble | ok 2025-04-19 03:09:42.223035 | 2025-04-19 03:09:42.223137 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-19 03:09:42.252943 | ubuntu-noble | ok 2025-04-19 03:09:42.259572 | 2025-04-19 03:09:42.259674 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-19 03:09:42.539381 | ubuntu-noble -> localhost | ok 2025-04-19 03:09:42.552490 | 2025-04-19 03:09:42.552625 | TASK [validate-host : Collect information about the host] 2025-04-19 03:09:43.651627 | ubuntu-noble | ok 2025-04-19 03:09:43.663719 | 2025-04-19 03:09:43.663817 | TASK [validate-host : Sanitize hostname] 2025-04-19 03:09:43.756615 | ubuntu-noble | ok 2025-04-19 03:09:43.763768 | 2025-04-19 03:09:43.763868 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-19 03:09:44.283747 | ubuntu-noble -> localhost | changed 2025-04-19 03:09:44.290642 | 2025-04-19 03:09:44.290749 | TASK [validate-host : Collect information about zuul worker] 2025-04-19 03:09:44.794301 | ubuntu-noble | ok 2025-04-19 03:09:44.803630 | 2025-04-19 03:09:44.803761 | TASK [validate-host : Write out all zuul information for each host] 2025-04-19 03:09:45.456591 | ubuntu-noble -> localhost | changed 2025-04-19 03:09:45.477863 | 2025-04-19 03:09:45.478002 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-19 03:09:45.796828 | ubuntu-noble | ok 2025-04-19 03:09:45.815801 | 2025-04-19 03:09:45.815956 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-19 03:09:46.791585 | ubuntu-noble | changed: 2025-04-19 03:09:46.791784 | ubuntu-noble | cd+++++++++ src/ 2025-04-19 03:09:46.791819 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-19 03:09:46.791844 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-19 03:09:46.791865 | ubuntu-noble | cd+++++++++ src/github.com/osism/rookify/ 2025-04-19 03:09:46.791886 | ubuntu-noble | Containerfile 2025-04-19 03:09:46.792032 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007003 2025-04-19 03:10:19.144252 | 2025-04-19 03:10:19.144345 | TASK [upload-logs : Upload logs to log server] 2025-04-19 03:10:19.727068 | localhost | Output suppressed because no_log was given 2025-04-19 03:10:19.730001 | 2025-04-19 03:10:19.730091 | LOOP [upload-logs : Compress console log and json output] 2025-04-19 03:10:19.822111 | localhost | skipping: Conditional result was False 2025-04-19 03:10:19.832223 | localhost | skipping: Conditional result was False 2025-04-19 03:10:19.839319 | 2025-04-19 03:10:19.839420 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-19 03:10:19.913360 | localhost | skipping: Conditional result was False 2025-04-19 03:10:19.913649 | 2025-04-19 03:10:19.914330 | localhost | skipping: Conditional result was False 2025-04-19 03:10:19.923747 | 2025-04-19 03:10:19.923847 | LOOP [upload-logs : Upload console log and json output]