2025-01-28 14:34:22.031947 | Job console starting... 2025-01-28 14:34:22.053771 | Updating repositories 2025-01-28 14:34:22.085343 | Preparing job workspace 2025-01-28 14:34:24.197739 | Running Ansible setup... 2025-01-28 14:34:29.914794 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-28 14:34:31.109400 | 2025-01-28 14:34:31.109570 | PLAY [Base pre] 2025-01-28 14:34:31.184172 | 2025-01-28 14:34:31.184344 | TASK [Setup log path fact] 2025-01-28 14:34:31.240645 | ubuntu-noble | ok 2025-01-28 14:34:31.288346 | 2025-01-28 14:34:31.288547 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-28 14:34:31.391434 | ubuntu-noble | ok 2025-01-28 14:34:31.398538 | 2025-01-28 14:34:31.398654 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-28 14:34:31.454433 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:31.462470 | 2025-01-28 14:34:31.462707 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-28 14:34:31.545157 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:31.552832 | 2025-01-28 14:34:31.552961 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-28 14:34:31.601464 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:31.609258 | 2025-01-28 14:34:31.609391 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-28 14:34:31.654873 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:31.662499 | 2025-01-28 14:34:31.662704 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-28 14:34:31.718054 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:31.739242 | 2025-01-28 14:34:31.739399 | TASK [emit-job-header : Print job information] 2025-01-28 14:34:31.842866 | # Job Information 2025-01-28 14:34:31.843096 | Ansible Version: 2.15.3 2025-01-28 14:34:31.843132 | Job: yamllint 2025-01-28 14:34:31.843162 | Pipeline: check 2025-01-28 14:34:31.843182 | Executor: 7d211f194f6a 2025-01-28 14:34:31.843202 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/153 2025-01-28 14:34:31.843221 | Event ID: f1cb0350-dd84-11ef-967c-41692e542c9e 2025-01-28 14:34:31.858382 | 2025-01-28 14:34:31.858520 | LOOP [emit-job-header : Print node information] 2025-01-28 14:34:32.087585 | ubuntu-noble | ok: 2025-01-28 14:34:32.087790 | ubuntu-noble | # Node Information 2025-01-28 14:34:32.087823 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-28 14:34:32.087848 | ubuntu-noble | Hostname: ubuntu 2025-01-28 14:34:32.087870 | ubuntu-noble | Username: zuul 2025-01-28 14:34:32.087890 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-28 14:34:32.087910 | ubuntu-noble | Provider: regiocloud-a 2025-01-28 14:34:32.087930 | ubuntu-noble | Label: ubuntu-noble 2025-01-28 14:34:32.087949 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-28 14:34:32.087994 | ubuntu-noble | Interface IP: 81.163.192.178 2025-01-28 14:34:32.109415 | 2025-01-28 14:34:32.109548 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-28 14:34:32.889279 | ubuntu-noble -> localhost | changed 2025-01-28 14:34:32.909665 | 2025-01-28 14:34:32.909778 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-28 14:34:34.467466 | ubuntu-noble -> localhost | changed 2025-01-28 14:34:34.481112 | 2025-01-28 14:34:34.481225 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-28 14:34:35.034749 | ubuntu-noble -> localhost | ok 2025-01-28 14:34:35.064440 | 2025-01-28 14:34:35.064540 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-28 14:34:35.103085 | ubuntu-noble | ok 2025-01-28 14:34:35.125293 | ubuntu-noble | included: /var/lib/zuul/builds/ec9bc05f7aab4816b63282d2267123ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-28 14:34:35.137946 | 2025-01-28 14:34:35.138061 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-28 14:34:36.026343 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-28 14:34:36.026633 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ec9bc05f7aab4816b63282d2267123ca/work/ec9bc05f7aab4816b63282d2267123ca_id_rsa 2025-01-28 14:34:36.026666 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ec9bc05f7aab4816b63282d2267123ca/work/ec9bc05f7aab4816b63282d2267123ca_id_rsa.pub 2025-01-28 14:34:36.026707 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-28 14:34:36.026792 | ubuntu-noble -> localhost | SHA256:Ko45Ef0Amc11K7XyK6rt9MbjNZjVnOluhGQASrPWOmc zuul-build-sshkey 2025-01-28 14:34:36.026812 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-28 14:34:36.026834 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-28 14:34:36.026852 | ubuntu-noble -> localhost | | o=.o. o | 2025-01-28 14:34:36.026869 | ubuntu-noble -> localhost | | .+=o .o o | 2025-01-28 14:34:36.026885 | ubuntu-noble -> localhost | | +o. o.o | 2025-01-28 14:34:36.026901 | ubuntu-noble -> localhost | | ...o +oo o | 2025-01-28 14:34:36.026917 | ubuntu-noble -> localhost | | o.Eo oS.= | 2025-01-28 14:34:36.026933 | ubuntu-noble -> localhost | | .+ .=.o. | 2025-01-28 14:34:36.026956 | ubuntu-noble -> localhost | | .o.= +.. | 2025-01-28 14:34:36.027274 | ubuntu-noble -> localhost | | .* ++o o. | 2025-01-28 14:34:36.027304 | ubuntu-noble -> localhost | | ++=oo. .. | 2025-01-28 14:34:36.027324 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-28 14:34:36.027368 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.390430 2025-01-28 14:34:36.039582 | 2025-01-28 14:34:36.039664 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-28 14:34:36.058750 | ubuntu-noble | ok 2025-01-28 14:34:36.068306 | ubuntu-noble | included: /var/lib/zuul/builds/ec9bc05f7aab4816b63282d2267123ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-28 14:34:36.077987 | 2025-01-28 14:34:36.078057 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-28 14:34:36.101845 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:36.108323 | 2025-01-28 14:34:36.108413 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-28 14:34:36.796029 | ubuntu-noble | changed 2025-01-28 14:34:36.806588 | 2025-01-28 14:34:36.806723 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-28 14:34:37.119173 | ubuntu-noble | ok 2025-01-28 14:34:37.135917 | 2025-01-28 14:34:37.136033 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-28 14:34:37.880463 | ubuntu-noble | changed 2025-01-28 14:34:37.889548 | 2025-01-28 14:34:37.889640 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-28 14:34:38.649247 | ubuntu-noble | changed 2025-01-28 14:34:38.655934 | 2025-01-28 14:34:38.656036 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-28 14:34:38.703105 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:38.709214 | 2025-01-28 14:34:38.709297 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-28 14:34:39.149017 | ubuntu-noble -> localhost | changed 2025-01-28 14:34:39.163859 | 2025-01-28 14:34:39.164094 | TASK [add-build-sshkey : Add back temp key] 2025-01-28 14:34:39.746166 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/ec9bc05f7aab4816b63282d2267123ca/work/ec9bc05f7aab4816b63282d2267123ca_id_rsa (zuul-build-sshkey) 2025-01-28 14:34:39.746504 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016205 2025-01-28 14:34:39.753332 | 2025-01-28 14:34:39.753425 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-28 14:34:40.153448 | ubuntu-noble | ok 2025-01-28 14:34:40.162327 | 2025-01-28 14:34:40.162425 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-28 14:34:40.186453 | ubuntu-noble | skipping: Conditional result was False 2025-01-28 14:34:40.201127 | 2025-01-28 14:34:40.201224 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-28 14:34:40.653725 | ubuntu-noble | ok 2025-01-28 14:34:40.667761 | 2025-01-28 14:34:40.667850 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-28 14:34:40.712684 | ubuntu-noble | ok 2025-01-28 14:34:40.721586 | 2025-01-28 14:34:40.721697 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-28 14:34:41.024073 | ubuntu-noble -> localhost | ok 2025-01-28 14:34:41.032370 | 2025-01-28 14:34:41.032529 | TASK [validate-host : Collect information about the host] 2025-01-28 14:34:42.253472 | ubuntu-noble | ok 2025-01-28 14:34:42.265622 | 2025-01-28 14:34:42.265749 | TASK [validate-host : Sanitize hostname] 2025-01-28 14:34:42.337768 | ubuntu-noble | ok 2025-01-28 14:34:42.344278 | 2025-01-28 14:34:42.344440 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-28 14:34:43.215008 | ubuntu-noble -> localhost | changed 2025-01-28 14:34:43.222604 | 2025-01-28 14:34:43.222730 | TASK [validate-host : Collect information about zuul worker] 2025-01-28 14:34:43.784756 | ubuntu-noble | ok 2025-01-28 14:34:43.799621 | 2025-01-28 14:34:43.799790 | TASK [validate-host : Write out all zuul information for each host] 2025-01-28 14:34:44.661775 | ubuntu-noble -> localhost | changed 2025-01-28 14:34:44.676207 | 2025-01-28 14:34:44.676348 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-28 14:34:45.014658 | ubuntu-noble | ok 2025-01-28 14:34:45.027545 | 2025-01-28 14:34:45.027767 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-28 14:34:45.985199 | ubuntu-noble | changed: 2025-01-28 14:34:45.985383 | ubuntu-noble | cd+++++++++ src/ 2025-01-28 14:34:45.985416 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-28 14:34:45.985441 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-28 14:34:45.985463 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-01-28 14:34:45.985484 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006949 2025-01-28 14:35:18.804187 | 2025-01-28 14:35:18.804326 | TASK [upload-logs : Upload logs to log server] 2025-01-28 14:35:19.536137 | localhost | Output suppressed because no_log was given 2025-01-28 14:35:19.539232 | 2025-01-28 14:35:19.539334 | LOOP [upload-logs : Compress console log and json output] 2025-01-28 14:35:19.627267 | localhost | skipping: Conditional result was False 2025-01-28 14:35:19.653622 | localhost | skipping: Conditional result was False 2025-01-28 14:35:19.669012 | 2025-01-28 14:35:19.672952 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-28 14:35:19.753551 | localhost | skipping: Conditional result was False 2025-01-28 14:35:19.754100 | 2025-01-28 14:35:19.766415 | localhost | skipping: Conditional result was False 2025-01-28 14:35:19.774846 | 2025-01-28 14:35:19.775029 | LOOP [upload-logs : Upload console log and json output]