2025-03-29 05:30:03.688304 | Job console starting... 2025-03-29 05:30:03.705401 | Updating repositories 2025-03-29 05:30:03.737079 | Preparing job workspace 2025-03-29 05:30:04.569222 | Running Ansible setup... 2025-03-29 05:30:09.185149 | PRE-RUN START: [trusted : github.com/regiocloud/zuul-config/playbooks/base/pre.yaml@main] 2025-03-29 05:30:09.881895 | 2025-03-29 05:30:09.882046 | PLAY [Base pre] 2025-03-29 05:30:09.911814 | 2025-03-29 05:30:09.911942 | TASK [Setup log path fact] 2025-03-29 05:30:09.943615 | ubuntu-jammy | ok 2025-03-29 05:30:09.962640 | 2025-03-29 05:30:09.962767 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-29 05:30:10.009731 | ubuntu-jammy | ok 2025-03-29 05:30:10.025232 | 2025-03-29 05:30:10.025348 | TASK [emit-job-header : Print job information] 2025-03-29 05:30:10.087115 | # Job Information 2025-03-29 05:30:10.087291 | Ansible Version: 2.15.3 2025-03-29 05:30:10.087326 | Job: e2e-tests-openstack 2025-03-29 05:30:10.087356 | Pipeline: periodic-hourly 2025-03-29 05:30:10.087377 | Executor: 7d211f194f6a 2025-03-29 05:30:10.087395 | Triggered by: https://github.com/regiocloud/e2e-tests 2025-03-29 05:30:10.087414 | Event ID: a8bcba1c768142d096397768f2e86a2e 2025-03-29 05:30:10.094106 | 2025-03-29 05:30:10.094216 | LOOP [emit-job-header : Print node information] 2025-03-29 05:30:10.241695 | ubuntu-jammy | ok: 2025-03-29 05:30:10.241959 | ubuntu-jammy | # Node Information 2025-03-29 05:30:10.241996 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-03-29 05:30:10.242020 | ubuntu-jammy | Hostname: ubuntu 2025-03-29 05:30:10.242042 | ubuntu-jammy | Username: zuul 2025-03-29 05:30:10.242061 | ubuntu-jammy | Distro: Ubuntu 24.04 2025-03-29 05:30:10.242085 | ubuntu-jammy | Provider: regiocloud-a 2025-03-29 05:30:10.242105 | ubuntu-jammy | Label: ubuntu-jammy 2025-03-29 05:30:10.242125 | ubuntu-jammy | Product Name: OpenStack Nova 2025-03-29 05:30:10.242145 | ubuntu-jammy | Interface IP: 81.163.192.237 2025-03-29 05:30:10.255640 | 2025-03-29 05:30:10.255752 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-29 05:30:10.717874 | ubuntu-jammy -> localhost | changed 2025-03-29 05:30:10.730535 | 2025-03-29 05:30:10.730738 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-29 05:30:11.780832 | ubuntu-jammy -> localhost | changed 2025-03-29 05:30:11.810660 | 2025-03-29 05:30:11.810792 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-29 05:30:12.089939 | ubuntu-jammy -> localhost | ok 2025-03-29 05:30:12.097631 | 2025-03-29 05:30:12.097752 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-29 05:30:12.135886 | ubuntu-jammy | ok 2025-03-29 05:30:12.156958 | ubuntu-jammy | included: /var/lib/zuul/builds/a53558a621534556940f4fcbc4eb63d1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-29 05:30:12.164915 | 2025-03-29 05:30:12.165027 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-29 05:30:12.825997 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-03-29 05:30:12.826250 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/a53558a621534556940f4fcbc4eb63d1/work/a53558a621534556940f4fcbc4eb63d1_id_rsa 2025-03-29 05:30:12.826289 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/a53558a621534556940f4fcbc4eb63d1/work/a53558a621534556940f4fcbc4eb63d1_id_rsa.pub 2025-03-29 05:30:12.826314 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-03-29 05:30:12.826338 | ubuntu-jammy -> localhost | SHA256:j40ILU2lnYgL9oP11e2N808QZGlXl7uKlgfMmz5C5Tc zuul-build-sshkey 2025-03-29 05:30:12.826361 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-03-29 05:30:12.826382 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-03-29 05:30:12.826403 | ubuntu-jammy -> localhost | | . o.=| 2025-03-29 05:30:12.826423 | ubuntu-jammy -> localhost | | . = o . oo.o| 2025-03-29 05:30:12.826443 | ubuntu-jammy -> localhost | | o o + + . .....| 2025-03-29 05:30:12.826473 | ubuntu-jammy -> localhost | | . = * . o o o | 2025-03-29 05:30:12.826493 | ubuntu-jammy -> localhost | | . * + S = + o .| 2025-03-29 05:30:12.826512 | ubuntu-jammy -> localhost | | + . * = E o | 2025-03-29 05:30:12.826535 | ubuntu-jammy -> localhost | | . + o B + .| 2025-03-29 05:30:12.826555 | ubuntu-jammy -> localhost | | . B o o | 2025-03-29 05:30:12.826595 | ubuntu-jammy -> localhost | | +.o .| 2025-03-29 05:30:12.826616 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-03-29 05:30:12.826669 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.168892 2025-03-29 05:30:12.834803 | 2025-03-29 05:30:12.834919 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-29 05:30:12.875047 | ubuntu-jammy | ok 2025-03-29 05:30:12.890037 | ubuntu-jammy | included: /var/lib/zuul/builds/a53558a621534556940f4fcbc4eb63d1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-29 05:30:12.900264 | 2025-03-29 05:30:12.900362 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-29 05:30:12.925659 | ubuntu-jammy | skipping: Conditional result was False 2025-03-29 05:30:12.933603 | 2025-03-29 05:30:12.933704 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-29 05:30:13.522905 | ubuntu-jammy | changed 2025-03-29 05:30:13.531303 | 2025-03-29 05:30:13.531414 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-29 05:30:13.826403 | ubuntu-jammy | ok 2025-03-29 05:30:13.836142 | 2025-03-29 05:30:13.836266 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-29 05:30:14.273295 | ubuntu-jammy | ok 2025-03-29 05:30:14.283331 | 2025-03-29 05:30:14.283451 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-29 05:30:14.713217 | ubuntu-jammy | ok 2025-03-29 05:30:14.720504 | 2025-03-29 05:30:14.720643 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-29 05:30:14.755157 | ubuntu-jammy | skipping: Conditional result was False 2025-03-29 05:30:14.762729 | 2025-03-29 05:30:14.762831 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-29 05:30:15.232604 | ubuntu-jammy -> localhost | changed 2025-03-29 05:30:15.258981 | 2025-03-29 05:30:15.259117 | TASK [add-build-sshkey : Add back temp key] 2025-03-29 05:30:15.622041 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/a53558a621534556940f4fcbc4eb63d1/work/a53558a621534556940f4fcbc4eb63d1_id_rsa (zuul-build-sshkey) 2025-03-29 05:30:15.622504 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.018170 2025-03-29 05:30:15.636610 | 2025-03-29 05:30:15.636745 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-29 05:30:16.060953 | ubuntu-jammy | ok 2025-03-29 05:30:16.068131 | 2025-03-29 05:30:16.068248 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-29 05:30:16.092700 | ubuntu-jammy | skipping: Conditional result was False 2025-03-29 05:30:16.106855 | 2025-03-29 05:30:16.106961 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-29 05:30:16.595985 | ubuntu-jammy | ok 2025-03-29 05:30:16.608279 | 2025-03-29 05:30:16.608415 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-29 05:30:16.649705 | ubuntu-jammy | ok 2025-03-29 05:30:16.656445 | 2025-03-29 05:30:16.656552 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-29 05:30:16.949966 | ubuntu-jammy -> localhost | ok 2025-03-29 05:30:16.966977 | 2025-03-29 05:30:16.967113 | TASK [validate-host : Collect information about the host] 2025-03-29 05:30:18.325577 | ubuntu-jammy | ok 2025-03-29 05:30:18.338836 | 2025-03-29 05:30:18.338957 | TASK [validate-host : Sanitize hostname] 2025-03-29 05:30:18.415481 | ubuntu-jammy | ok 2025-03-29 05:30:18.425231 | 2025-03-29 05:30:18.425372 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-29 05:30:18.962205 | ubuntu-jammy -> localhost | changed 2025-03-29 05:30:18.976551 | 2025-03-29 05:30:18.976774 | TASK [validate-host : Collect information about zuul worker] 2025-03-29 05:30:19.446234 | ubuntu-jammy | ok 2025-03-29 05:30:19.454018 | 2025-03-29 05:30:19.454133 | TASK [validate-host : Write out all zuul information for each host] 2025-03-29 05:30:19.987394 | ubuntu-jammy -> localhost | changed 2025-03-29 05:30:20.001066 | 2025-03-29 05:30:20.001181 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-29 05:30:20.318540 | ubuntu-jammy | ok 2025-03-29 05:30:20.327338 | 2025-03-29 05:30:20.327445 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-29 05:30:21.212792 | ubuntu-jammy | changed: 2025-03-29 05:30:21.212997 | ubuntu-jammy | .d..t...... src/ 2025-03-29 05:30:21.213036 | ubuntu-jammy | .d..t...... src/github.com/ 2025-03-29 05:30:21.213060 | ubuntu-jammy | cd+++++++++ src/github.com/regiocloud/ 2025-03-29 05:30:21.213081 | ubuntu-jammy | cd+++++++++ src/github.com/regiocloud/e2e-tests/ 2025-03-29 05:30:21.213100 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.006325 2025-03-29 05:30:45.293266 | 2025-03-29 05:30:45.293362 | TASK [upload-logs : Upload logs to log server] 2025-03-29 05:30:45.779206 | localhost | Output suppressed because no_log was given 2025-03-29 05:30:45.782652 | 2025-03-29 05:30:45.782763 | LOOP [upload-logs : Compress console log and json output] 2025-03-29 05:30:45.838096 | localhost | skipping: Conditional result was False 2025-03-29 05:30:45.854694 | localhost | skipping: Conditional result was False 2025-03-29 05:30:45.866179 | 2025-03-29 05:30:45.866361 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-29 05:30:45.932226 | localhost | skipping: Conditional result was False 2025-03-29 05:30:45.932509 | 2025-03-29 05:30:45.944692 | localhost | skipping: Conditional result was False 2025-03-29 05:30:45.964122 | 2025-03-29 05:30:45.964345 | LOOP [upload-logs : Upload console log and json output]