2025-04-16 03:13:19.834716 | Job console starting... 2025-04-16 03:13:19.886703 | Updating repositories 2025-04-16 03:13:19.926842 | Preparing job workspace 2025-04-16 03:13:21.073821 | Running Ansible setup... 2025-04-16 03:13:26.413923 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-16 03:13:27.200749 | 2025-04-16 03:13:27.200882 | PLAY [Base pre] 2025-04-16 03:13:27.228177 | 2025-04-16 03:13:27.228305 | TASK [Setup log path fact] 2025-04-16 03:13:27.258713 | ubuntu-noble | ok 2025-04-16 03:13:27.297392 | 2025-04-16 03:13:27.297643 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-16 03:13:27.328179 | ubuntu-noble | ok 2025-04-16 03:13:27.342336 | 2025-04-16 03:13:27.342439 | TASK [emit-job-header : Print job information] 2025-04-16 03:13:27.393595 | # Job Information 2025-04-16 03:13:27.393749 | Ansible Version: 2.15.3 2025-04-16 03:13:27.393782 | Job: python-black 2025-04-16 03:13:27.393811 | Pipeline: periodic-daily 2025-04-16 03:13:27.393832 | Executor: 7d211f194f6a 2025-04-16 03:13:27.393851 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-04-16 03:13:27.393870 | Event ID: 63f296e9c28746c38f6a57b5e8525c66 2025-04-16 03:13:27.404110 | 2025-04-16 03:13:27.404225 | LOOP [emit-job-header : Print node information] 2025-04-16 03:13:27.552168 | ubuntu-noble | ok: 2025-04-16 03:13:27.552328 | ubuntu-noble | # Node Information 2025-04-16 03:13:27.552362 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-16 03:13:27.552399 | ubuntu-noble | Hostname: ubuntu 2025-04-16 03:13:27.552435 | ubuntu-noble | Username: zuul 2025-04-16 03:13:27.552456 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-16 03:13:27.552480 | ubuntu-noble | Provider: regiocloud-a 2025-04-16 03:13:27.552500 | ubuntu-noble | Label: ubuntu-noble 2025-04-16 03:13:27.552521 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-16 03:13:27.552540 | ubuntu-noble | Interface IP: 81.163.193.211 2025-04-16 03:13:27.573773 | 2025-04-16 03:13:27.573885 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-16 03:13:28.038370 | ubuntu-noble -> localhost | changed 2025-04-16 03:13:28.051703 | 2025-04-16 03:13:28.051825 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-16 03:13:29.082542 | ubuntu-noble -> localhost | changed 2025-04-16 03:13:29.097086 | 2025-04-16 03:13:29.097206 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-16 03:13:29.366924 | ubuntu-noble -> localhost | ok 2025-04-16 03:13:29.376638 | 2025-04-16 03:13:29.376756 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-16 03:13:29.421875 | ubuntu-noble | ok 2025-04-16 03:13:29.440977 | ubuntu-noble | included: /var/lib/zuul/builds/d8722c48c0ff4d3c89507260cba1c04e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-16 03:13:29.449438 | 2025-04-16 03:13:29.449544 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-16 03:13:30.694348 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-16 03:13:30.694610 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8722c48c0ff4d3c89507260cba1c04e/work/d8722c48c0ff4d3c89507260cba1c04e_id_rsa 2025-04-16 03:13:30.694657 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8722c48c0ff4d3c89507260cba1c04e/work/d8722c48c0ff4d3c89507260cba1c04e_id_rsa.pub 2025-04-16 03:13:30.694689 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-16 03:13:30.694719 | ubuntu-noble -> localhost | SHA256:l4ZqR6wOjhcxgTDJXlAdLeB7dU+m8p8Xm3zYMqAs4I8 zuul-build-sshkey 2025-04-16 03:13:30.694747 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-16 03:13:30.694772 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-16 03:13:30.694798 | ubuntu-noble -> localhost | |++o+o.o | 2025-04-16 03:13:30.694822 | ubuntu-noble -> localhost | |.oo..o . | 2025-04-16 03:13:30.694845 | ubuntu-noble -> localhost | |. .. ... . o | 2025-04-16 03:13:30.694878 | ubuntu-noble -> localhost | | . + ....=. | 2025-04-16 03:13:30.694903 | ubuntu-noble -> localhost | | . + .S.+. | 2025-04-16 03:13:30.694926 | ubuntu-noble -> localhost | | o. +oo . . | 2025-04-16 03:13:30.694956 | ubuntu-noble -> localhost | | o.= o.. o * | 2025-04-16 03:13:30.694982 | ubuntu-noble -> localhost | | o.=.o o. .O o | 2025-04-16 03:13:30.695005 | ubuntu-noble -> localhost | | ...Eo.. o. + | 2025-04-16 03:13:30.695029 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-16 03:13:30.695087 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.749666 2025-04-16 03:13:30.704350 | 2025-04-16 03:13:30.704500 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-16 03:13:30.738933 | ubuntu-noble | ok 2025-04-16 03:13:30.751545 | ubuntu-noble | included: /var/lib/zuul/builds/d8722c48c0ff4d3c89507260cba1c04e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-16 03:13:30.761895 | 2025-04-16 03:13:30.761980 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-16 03:13:30.786188 | ubuntu-noble | skipping: Conditional result was False 2025-04-16 03:13:30.794998 | 2025-04-16 03:13:30.795090 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-16 03:13:31.573908 | ubuntu-noble | changed 2025-04-16 03:13:31.583091 | 2025-04-16 03:13:31.583255 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-16 03:13:31.877724 | ubuntu-noble | ok 2025-04-16 03:13:31.889840 | 2025-04-16 03:13:31.889984 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-16 03:13:32.686053 | ubuntu-noble | changed 2025-04-16 03:13:32.697241 | 2025-04-16 03:13:32.697400 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-16 03:13:33.457869 | ubuntu-noble | changed 2025-04-16 03:13:33.465250 | 2025-04-16 03:13:33.476414 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-16 03:13:33.523561 | ubuntu-noble | skipping: Conditional result was False 2025-04-16 03:13:33.533954 | 2025-04-16 03:13:33.534095 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-16 03:13:34.221590 | ubuntu-noble -> localhost | changed 2025-04-16 03:13:34.237286 | 2025-04-16 03:13:34.237400 | TASK [add-build-sshkey : Add back temp key] 2025-04-16 03:13:34.605572 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d8722c48c0ff4d3c89507260cba1c04e/work/d8722c48c0ff4d3c89507260cba1c04e_id_rsa (zuul-build-sshkey) 2025-04-16 03:13:34.605974 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011336 2025-04-16 03:13:34.627110 | 2025-04-16 03:13:34.627245 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-16 03:13:35.119303 | ubuntu-noble | ok 2025-04-16 03:13:35.132081 | 2025-04-16 03:13:35.132238 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-16 03:13:35.186891 | ubuntu-noble | skipping: Conditional result was False 2025-04-16 03:13:35.210137 | 2025-04-16 03:13:35.210248 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-16 03:13:35.786212 | ubuntu-noble | ok 2025-04-16 03:13:35.798404 | 2025-04-16 03:13:35.798495 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-16 03:13:35.839985 | ubuntu-noble | ok 2025-04-16 03:13:35.846428 | 2025-04-16 03:13:35.846524 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-16 03:13:36.135761 | ubuntu-noble -> localhost | ok 2025-04-16 03:13:36.151541 | 2025-04-16 03:13:36.151683 | TASK [validate-host : Collect information about the host] 2025-04-16 03:13:37.312898 | ubuntu-noble | ok 2025-04-16 03:13:37.324653 | 2025-04-16 03:13:37.324751 | TASK [validate-host : Sanitize hostname] 2025-04-16 03:13:37.384652 | ubuntu-noble | ok 2025-04-16 03:13:37.391103 | 2025-04-16 03:13:37.391209 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-16 03:13:37.976987 | ubuntu-noble -> localhost | changed 2025-04-16 03:13:37.984265 | 2025-04-16 03:13:37.984360 | TASK [validate-host : Collect information about zuul worker] 2025-04-16 03:13:38.441493 | ubuntu-noble | ok 2025-04-16 03:13:38.448050 | 2025-04-16 03:13:38.448157 | TASK [validate-host : Write out all zuul information for each host] 2025-04-16 03:13:38.964908 | ubuntu-noble -> localhost | changed 2025-04-16 03:13:38.976723 | 2025-04-16 03:13:38.976828 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-16 03:13:39.332505 | ubuntu-noble | ok 2025-04-16 03:13:39.340992 | 2025-04-16 03:13:39.341117 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-16 03:13:40.422750 | ubuntu-noble | changed: 2025-04-16 03:13:40.422914 | ubuntu-noble | cd+++++++++ src/ 2025-04-16 03:13:40.422948 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-16 03:13:40.422973 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-16 03:13:40.422995 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-04-16 03:13:40.423015 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007551 2025-04-16 03:14:11.334647 | 2025-04-16 03:14:11.334760 | TASK [upload-logs : Upload logs to log server] 2025-04-16 03:14:12.002804 | localhost | Output suppressed because no_log was given 2025-04-16 03:14:12.010195 | 2025-04-16 03:14:12.010537 | LOOP [upload-logs : Compress console log and json output] 2025-04-16 03:14:12.151247 | localhost | skipping: Conditional result was False 2025-04-16 03:14:12.169676 | localhost | skipping: Conditional result was False 2025-04-16 03:14:12.184222 | 2025-04-16 03:14:12.184363 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-16 03:14:12.270746 | localhost | skipping: Conditional result was False 2025-04-16 03:14:12.271953 | 2025-04-16 03:14:12.273391 | localhost | skipping: Conditional result was False 2025-04-16 03:14:12.282487 | 2025-04-16 03:14:12.282680 | LOOP [upload-logs : Upload console log and json output]