2025-10-11 18:24:04.370181 | Job console starting 2025-10-11 18:24:04.403656 | Updating git repos 2025-10-11 18:24:04.436620 | Cloning repos into workspace 2025-10-11 18:24:04.497431 | Restoring repo states 2025-10-11 18:24:04.518654 | Merging changes 2025-10-11 18:24:05.058117 | Checking out repos 2025-10-11 18:24:05.180824 | Preparing playbooks 2025-10-11 18:24:05.755257 | Running Ansible setup 2025-10-11 18:24:33.034296 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-11 18:24:33.776295 | 2025-10-11 18:24:33.776444 | PLAY [Base pre] 2025-10-11 18:24:33.793851 | 2025-10-11 18:24:33.793980 | TASK [Setup log path fact] 2025-10-11 18:24:33.821988 | centos-9-stream | ok 2025-10-11 18:24:33.835458 | 2025-10-11 18:24:33.835581 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-11 18:24:33.873933 | centos-9-stream | ok 2025-10-11 18:24:33.882991 | 2025-10-11 18:24:33.883097 | TASK [emit-job-header : Print job information] 2025-10-11 18:24:33.925382 | # Job Information 2025-10-11 18:24:33.925655 | Ansible Version: 2.16.14 2025-10-11 18:24:33.925751 | Job: ansible-collection-services-molecule-substation 2025-10-11 18:24:33.925824 | Pipeline: check 2025-10-11 18:24:33.925874 | Executor: 521e9411259a 2025-10-11 18:24:33.925918 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2009 2025-10-11 18:24:33.925966 | Event ID: ccdc8740-a6c8-11f0-8f02-9135b1b2579c 2025-10-11 18:24:33.932536 | 2025-10-11 18:24:33.932667 | LOOP [emit-job-header : Print node information] 2025-10-11 18:24:34.030087 | centos-9-stream | ok: 2025-10-11 18:24:34.030489 | centos-9-stream | # Node Information 2025-10-11 18:24:34.030578 | centos-9-stream | Inventory Hostname: centos-9-stream 2025-10-11 18:24:34.030638 | centos-9-stream | Hostname: np0000126004 2025-10-11 18:24:34.030690 | centos-9-stream | Username: zuul 2025-10-11 18:24:34.030799 | centos-9-stream | Distro: CentOS 9 2025-10-11 18:24:34.030885 | centos-9-stream | Provider: regiocloud-a 2025-10-11 18:24:34.030939 | centos-9-stream | Region: 2025-10-11 18:24:34.030991 | centos-9-stream | Label: centos-9-stream 2025-10-11 18:24:34.031036 | centos-9-stream | Product Name: OpenStack Nova 2025-10-11 18:24:34.031080 | centos-9-stream | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5a:3af8 2025-10-11 18:24:34.083789 | centos-9-stream | ok: 2025-10-11 18:24:34.083994 | centos-9-stream | # Node Information 2025-10-11 18:24:34.084076 | centos-9-stream | Inventory Hostname: debian-bookworm 2025-10-11 18:24:34.084136 | centos-9-stream | Hostname: debian 2025-10-11 18:24:34.084199 | centos-9-stream | Username: zuul 2025-10-11 18:24:34.084251 | centos-9-stream | Distro: Debian 12.12 2025-10-11 18:24:34.084303 | centos-9-stream | Provider: regiocloud-a 2025-10-11 18:24:34.084354 | centos-9-stream | Region: 2025-10-11 18:24:34.084403 | centos-9-stream | Label: debian-bookworm 2025-10-11 18:24:34.084450 | centos-9-stream | Product Name: OpenStack Nova 2025-10-11 18:24:34.084498 | centos-9-stream | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb7:f1fa 2025-10-11 18:24:34.129842 | centos-9-stream | ok: 2025-10-11 18:24:34.130035 | centos-9-stream | # Node Information 2025-10-11 18:24:34.130212 | centos-9-stream | Inventory Hostname: ubuntu-jammy 2025-10-11 18:24:34.130340 | centos-9-stream | Hostname: ubuntu 2025-10-11 18:24:34.130401 | centos-9-stream | Username: zuul 2025-10-11 18:24:34.130456 | centos-9-stream | Distro: Ubuntu 22.04 2025-10-11 18:24:34.130507 | centos-9-stream | Provider: regiocloud-a 2025-10-11 18:24:34.130559 | centos-9-stream | Region: 2025-10-11 18:24:34.130608 | centos-9-stream | Label: ubuntu-jammy 2025-10-11 18:24:34.130656 | centos-9-stream | Product Name: OpenStack Nova 2025-10-11 18:24:34.130704 | centos-9-stream | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feef:391b 2025-10-11 18:24:34.179444 | centos-9-stream | ok: 2025-10-11 18:24:34.179604 | centos-9-stream | # Node Information 2025-10-11 18:24:34.179666 | centos-9-stream | Inventory Hostname: ubuntu-noble 2025-10-11 18:24:34.179728 | centos-9-stream | Hostname: ubuntu 2025-10-11 18:24:34.179798 | centos-9-stream | Username: zuul 2025-10-11 18:24:34.179853 | centos-9-stream | Distro: Ubuntu 24.04 2025-10-11 18:24:34.179895 | centos-9-stream | Provider: regiocloud-a 2025-10-11 18:24:34.179935 | centos-9-stream | Region: 2025-10-11 18:24:34.179977 | centos-9-stream | Label: ubuntu-noble 2025-10-11 18:24:34.180018 | centos-9-stream | Product Name: OpenStack Nova 2025-10-11 18:24:34.180057 | centos-9-stream | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3b:c5ca 2025-10-11 18:24:34.203748 | 2025-10-11 18:24:34.203876 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-11 18:24:34.687543 | centos-9-stream -> localhost | changed 2025-10-11 18:24:34.701500 | 2025-10-11 18:24:34.701684 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-11 18:24:35.868102 | ubuntu-jammy -> localhost | changed 2025-10-11 18:24:35.879747 | centos-9-stream -> localhost | ok 2025-10-11 18:24:35.880647 | debian-bookworm -> localhost | ok 2025-10-11 18:24:36.053271 | ubuntu-noble -> localhost | ok 2025-10-11 18:24:36.092314 | 2025-10-11 18:24:36.092487 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-11 18:24:36.391869 | centos-9-stream -> localhost | ok 2025-10-11 18:24:36.406350 | 2025-10-11 18:24:36.406533 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-11 18:24:36.429343 | centos-9-stream | ok 2025-10-11 18:24:36.456199 | debian-bookworm | ok 2025-10-11 18:24:36.460975 | ubuntu-jammy | ok 2025-10-11 18:24:36.475622 | ubuntu-noble | ok 2025-10-11 18:24:36.503783 | centos-9-stream | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 18:24:36.503869 | debian-bookworm | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 18:24:36.503899 | ubuntu-jammy | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 18:24:36.503922 | ubuntu-noble | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 18:24:36.510339 | 2025-10-11 18:24:36.510432 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-11 18:24:39.338277 | centos-9-stream -> localhost | Generating public/private rsa key pair. 2025-10-11 18:24:39.338740 | centos-9-stream -> localhost | Your identification has been saved in /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/work/ba1e6a43566c4268a3f85d49ca21b045_id_rsa 2025-10-11 18:24:39.338870 | centos-9-stream -> localhost | Your public key has been saved in /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/work/ba1e6a43566c4268a3f85d49ca21b045_id_rsa.pub 2025-10-11 18:24:39.338941 | centos-9-stream -> localhost | The key fingerprint is: 2025-10-11 18:24:39.339003 | centos-9-stream -> localhost | SHA256:9+pU7a4uz12JQVXiWU9mG6SsuzMg2qk8AKgtjfOvL5w zuul-build-sshkey 2025-10-11 18:24:39.339061 | centos-9-stream -> localhost | The key's randomart image is: 2025-10-11 18:24:39.339117 | centos-9-stream -> localhost | +---[RSA 3072]----+ 2025-10-11 18:24:39.339169 | centos-9-stream -> localhost | | o+B| 2025-10-11 18:24:39.339223 | centos-9-stream -> localhost | | ..oB+| 2025-10-11 18:24:39.339273 | centos-9-stream -> localhost | |. +o..| 2025-10-11 18:24:39.339321 | centos-9-stream -> localhost | |.. o. | 2025-10-11 18:24:39.339369 | centos-9-stream -> localhost | |.+. S ..... | 2025-10-11 18:24:39.339415 | centos-9-stream -> localhost | |= o. . o o..o .| 2025-10-11 18:24:39.339465 | centos-9-stream -> localhost | | = .. o o o......| 2025-10-11 18:24:39.339513 | centos-9-stream -> localhost | | E .o o ..=.o . | 2025-10-11 18:24:39.339578 | centos-9-stream -> localhost | | .=ooo .o=B.o | 2025-10-11 18:24:39.339627 | centos-9-stream -> localhost | +----[SHA256]-----+ 2025-10-11 18:24:39.339764 | centos-9-stream -> localhost | ok: Runtime: 0:00:02.307243 2025-10-11 18:24:39.353249 | 2025-10-11 18:24:39.353404 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-11 18:24:39.390044 | centos-9-stream | ok 2025-10-11 18:24:39.410231 | debian-bookworm | ok 2025-10-11 18:24:39.415586 | ubuntu-jammy | ok 2025-10-11 18:24:39.419812 | ubuntu-noble | ok 2025-10-11 18:24:39.452650 | centos-9-stream | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 18:24:39.452781 | debian-bookworm | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 18:24:39.452816 | ubuntu-jammy | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 18:24:39.452838 | ubuntu-noble | included: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 18:24:39.469980 | 2025-10-11 18:24:39.470096 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-11 18:24:39.514662 | centos-9-stream | skipping: Conditional result was False 2025-10-11 18:24:39.528972 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:24:39.550635 | ubuntu-jammy | skipping: Conditional result was False 2025-10-11 18:24:39.571379 | ubuntu-noble | skipping: Conditional result was False 2025-10-11 18:24:39.576688 | 2025-10-11 18:24:39.576828 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-11 18:24:40.257628 | centos-9-stream | changed 2025-10-11 18:24:40.264123 | ubuntu-jammy | changed 2025-10-11 18:24:40.357342 | ubuntu-noble | changed 2025-10-11 18:24:40.377599 | debian-bookworm | changed 2025-10-11 18:24:40.384729 | 2025-10-11 18:24:40.384891 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-11 18:24:40.675033 | ubuntu-jammy | ok 2025-10-11 18:24:40.706012 | debian-bookworm | ok 2025-10-11 18:24:40.713183 | centos-9-stream | ok 2025-10-11 18:24:40.719604 | ubuntu-noble | ok 2025-10-11 18:24:40.724826 | 2025-10-11 18:24:40.724933 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-11 18:24:41.429354 | ubuntu-jammy | changed 2025-10-11 18:24:41.494619 | debian-bookworm | changed 2025-10-11 18:24:41.514199 | ubuntu-noble | changed 2025-10-11 18:24:41.756421 | centos-9-stream | changed 2025-10-11 18:24:41.764969 | 2025-10-11 18:24:41.765204 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-11 18:24:42.435842 | debian-bookworm | changed 2025-10-11 18:24:42.463181 | ubuntu-jammy | changed 2025-10-11 18:24:42.536939 | ubuntu-noble | changed 2025-10-11 18:24:42.717120 | centos-9-stream | changed 2025-10-11 18:24:42.725470 | 2025-10-11 18:24:42.725740 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-11 18:24:42.756171 | centos-9-stream | skipping: Conditional result was False 2025-10-11 18:24:42.769452 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:24:42.770620 | ubuntu-jammy | skipping: Conditional result was False 2025-10-11 18:24:42.781160 | ubuntu-noble | skipping: Conditional result was False 2025-10-11 18:24:42.786786 | 2025-10-11 18:24:42.786935 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-11 18:24:43.196020 | centos-9-stream -> localhost | changed 2025-10-11 18:24:43.226604 | 2025-10-11 18:24:43.226760 | TASK [add-build-sshkey : Add back temp key] 2025-10-11 18:24:43.606645 | centos-9-stream -> localhost | Identity added: /var/lib/zuul/builds/ba1e6a43566c4268a3f85d49ca21b045/work/ba1e6a43566c4268a3f85d49ca21b045_id_rsa (zuul-build-sshkey) 2025-10-11 18:24:43.607293 | centos-9-stream -> localhost | ok: Runtime: 0:00:00.019550 2025-10-11 18:24:43.618872 | 2025-10-11 18:24:43.619019 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-11 18:24:44.041075 | debian-bookworm | ok 2025-10-11 18:24:44.045845 | ubuntu-jammy | ok 2025-10-11 18:24:44.071995 | ubuntu-noble | ok 2025-10-11 18:24:44.075319 | centos-9-stream | ok 2025-10-11 18:24:44.079356 | 2025-10-11 18:24:44.079455 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-11 18:24:44.109380 | centos-9-stream | skipping: Conditional result was False 2025-10-11 18:24:44.122551 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:24:44.133975 | ubuntu-jammy | skipping: Conditional result was False 2025-10-11 18:24:44.144397 | ubuntu-noble | skipping: Conditional result was False 2025-10-11 18:24:44.165876 | 2025-10-11 18:24:44.165975 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-11 18:24:44.612128 | ubuntu-jammy | ok 2025-10-11 18:24:44.617896 | debian-bookworm | ok 2025-10-11 18:24:44.621492 | centos-9-stream | ok 2025-10-11 18:24:44.636114 | ubuntu-noble | ok 2025-10-11 18:24:44.657691 | 2025-10-11 18:24:44.657834 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-11 18:24:44.694183 | centos-9-stream | ok 2025-10-11 18:24:44.710293 | debian-bookworm | ok 2025-10-11 18:24:44.718053 | ubuntu-jammy | ok 2025-10-11 18:24:44.722198 | ubuntu-noble | ok 2025-10-11 18:24:44.726254 | 2025-10-11 18:24:44.727459 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-11 18:24:45.035184 | centos-9-stream -> localhost | ok 2025-10-11 18:24:45.043922 | 2025-10-11 18:24:45.044067 | TASK [validate-host : Collect information about the host] 2025-10-11 18:24:46.208289 | centos-9-stream | ok 2025-10-11 18:24:46.236265 | debian-bookworm | ok 2025-10-11 18:24:46.337585 | ubuntu-noble | ok 2025-10-11 18:24:57.015070 | ubuntu-jammy | ok 2025-10-11 18:24:57.028190 | 2025-10-11 18:24:57.028311 | TASK [validate-host : Sanitize hostname] 2025-10-11 18:24:57.153531 | centos-9-stream | ok 2025-10-11 18:24:57.158339 | debian-bookworm | ok 2025-10-11 18:24:57.182738 | ubuntu-noble | ok 2025-10-11 18:24:57.196928 | ubuntu-jammy | ok 2025-10-11 18:24:57.201249 | 2025-10-11 18:24:57.201357 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-11 18:24:57.877153 | debian-bookworm -> localhost | changed 2025-10-11 18:24:57.889012 | centos-9-stream -> localhost | changed 2025-10-11 18:24:57.901792 | ubuntu-noble -> localhost | changed 2025-10-11 18:24:57.924510 | ubuntu-jammy -> localhost | changed 2025-10-11 18:24:57.934575 | 2025-10-11 18:24:57.934826 | TASK [validate-host : Collect information about zuul worker] 2025-10-11 18:24:58.340440 | ubuntu-jammy | ok 2025-10-11 18:24:58.347192 | debian-bookworm | ok 2025-10-11 18:24:58.405123 | centos-9-stream | ok 2025-10-11 18:24:58.409141 | ubuntu-noble | ok 2025-10-11 18:24:58.412978 | 2025-10-11 18:24:58.413078 | TASK [validate-host : Write out all zuul information for each host] 2025-10-11 18:24:59.005635 | ubuntu-noble -> localhost | changed 2025-10-11 18:24:59.007041 | debian-bookworm -> localhost | changed 2025-10-11 18:24:59.058802 | centos-9-stream -> localhost | changed 2025-10-11 18:24:59.122958 | ubuntu-jammy -> localhost | changed 2025-10-11 18:24:59.150920 | 2025-10-11 18:24:59.151043 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-11 18:24:59.445263 | debian-bookworm | ok 2025-10-11 18:24:59.454533 | ubuntu-jammy | ok 2025-10-11 18:24:59.483415 | centos-9-stream | ok 2025-10-11 18:24:59.500386 | ubuntu-noble | ok 2025-10-11 18:24:59.507796 | 2025-10-11 18:24:59.507937 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-11 18:25:00.659316 | debian-bookworm | changed: 2025-10-11 18:25:00.659804 | debian-bookworm | cd+++++++++ src/ 2025-10-11 18:25:00.659907 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-11 18:25:00.659966 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-11 18:25:00.660004 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-11 18:25:00.660038 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010064 2025-10-11 18:54:45.456568 | 2025-10-11 18:54:45.456691 | TASK [upload-logs : Upload logs to log server] 2025-10-11 18:54:46.027259 | localhost | Output suppressed because no_log was given 2025-10-11 18:54:46.031408 | 2025-10-11 18:54:46.031590 | LOOP [upload-logs : Compress console log and json output] 2025-10-11 18:54:46.092464 | localhost | skipping: Conditional result was False 2025-10-11 18:54:46.097610 | localhost | skipping: Conditional result was False 2025-10-11 18:54:46.105071 | 2025-10-11 18:54:46.105288 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-11 18:54:46.154776 | localhost | skipping: Conditional result was False 2025-10-11 18:54:46.155418 | 2025-10-11 18:54:46.159025 | localhost | skipping: Conditional result was False 2025-10-11 18:54:46.166312 | 2025-10-11 18:54:46.166553 | LOOP [upload-logs : Upload console log and json output]