2025-03-05 22:57:31.721333 | Job console starting... 2025-03-05 22:57:31.741477 | Updating repositories 2025-03-05 22:57:31.772908 | Preparing job workspace 2025-03-05 22:57:34.962928 | Running Ansible setup... 2025-03-05 22:57:42.812864 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-05 22:57:44.279097 | 2025-03-05 22:57:44.279219 | PLAY [Base pre] 2025-03-05 22:57:44.344336 | 2025-03-05 22:57:44.344486 | TASK [Setup log path fact] 2025-03-05 22:57:44.395816 | ubuntu-noble | ok 2025-03-05 22:57:44.429456 | 2025-03-05 22:57:44.429567 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 22:57:44.486482 | ubuntu-noble | ok 2025-03-05 22:57:44.491898 | 2025-03-05 22:57:44.491978 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 22:57:44.556089 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:44.562957 | 2025-03-05 22:57:44.563068 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 22:57:44.642245 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:44.648331 | 2025-03-05 22:57:44.648438 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 22:57:44.691820 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:44.697580 | 2025-03-05 22:57:44.697666 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 22:57:44.741813 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:44.747716 | 2025-03-05 22:57:44.747798 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 22:57:44.780977 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:44.810728 | 2025-03-05 22:57:44.810831 | TASK [emit-job-header : Print job information] 2025-03-05 22:57:44.908006 | # Job Information 2025-03-05 22:57:44.908131 | Ansible Version: 2.15.3 2025-03-05 22:57:44.908156 | Job: ansible-lint 2025-03-05 22:57:44.908179 | Pipeline: check 2025-03-05 22:57:44.908195 | Executor: 7d211f194f6a 2025-03-05 22:57:44.908211 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/710 2025-03-05 22:57:44.908226 | Event ID: 338f9600-fa15-11ef-8bc5-30a18308c61b 2025-03-05 22:57:44.916346 | 2025-03-05 22:57:44.916441 | LOOP [emit-job-header : Print node information] 2025-03-05 22:57:45.267075 | ubuntu-noble | ok: 2025-03-05 22:57:45.267205 | ubuntu-noble | # Node Information 2025-03-05 22:57:45.267232 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-05 22:57:45.267252 | ubuntu-noble | Hostname: ubuntu 2025-03-05 22:57:45.267292 | ubuntu-noble | Username: zuul 2025-03-05 22:57:45.267309 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-05 22:57:45.267325 | ubuntu-noble | Provider: regiocloud-a 2025-03-05 22:57:45.267341 | ubuntu-noble | Label: ubuntu-noble 2025-03-05 22:57:45.267357 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-05 22:57:45.267373 | ubuntu-noble | Interface IP: 81.163.193.169 2025-03-05 22:57:45.304467 | 2025-03-05 22:57:45.304565 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-05 22:57:46.199277 | ubuntu-noble -> localhost | changed 2025-03-05 22:57:46.206166 | 2025-03-05 22:57:46.206246 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-05 22:57:47.817003 | ubuntu-noble -> localhost | changed 2025-03-05 22:57:47.829104 | 2025-03-05 22:57:47.829189 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-05 22:57:48.412236 | ubuntu-noble -> localhost | ok 2025-03-05 22:57:48.418285 | 2025-03-05 22:57:48.418366 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-05 22:57:48.466002 | ubuntu-noble | ok 2025-03-05 22:57:48.493078 | ubuntu-noble | included: /var/lib/zuul/builds/0279077655664662a8effc6245fe7152/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-05 22:57:48.511809 | 2025-03-05 22:57:48.511903 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-05 22:57:49.558066 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-05 22:57:49.558238 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0279077655664662a8effc6245fe7152/work/0279077655664662a8effc6245fe7152_id_rsa 2025-03-05 22:57:49.558286 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0279077655664662a8effc6245fe7152/work/0279077655664662a8effc6245fe7152_id_rsa.pub 2025-03-05 22:57:49.558313 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-05 22:57:49.558335 | ubuntu-noble -> localhost | SHA256:khztgf3GM6eU1AO1hSJMMKR7Zvz3IrD3zoKNbpZwSUA zuul-build-sshkey 2025-03-05 22:57:49.558357 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-05 22:57:49.558382 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-05 22:57:49.558403 | ubuntu-noble -> localhost | | .E.++. ..... | 2025-03-05 22:57:49.558423 | ubuntu-noble -> localhost | | .. =o .o.o | 2025-03-05 22:57:49.558443 | ubuntu-noble -> localhost | | ..o +...+ | 2025-03-05 22:57:49.558462 | ubuntu-noble -> localhost | | +.+ = . . | 2025-03-05 22:57:49.558481 | ubuntu-noble -> localhost | | ..O.S O . | 2025-03-05 22:57:49.558501 | ubuntu-noble -> localhost | | .++o o = | 2025-03-05 22:57:49.558520 | ubuntu-noble -> localhost | | o B. o | 2025-03-05 22:57:49.558540 | ubuntu-noble -> localhost | | B =o.. | 2025-03-05 22:57:49.558560 | ubuntu-noble -> localhost | | +.. =+.. | 2025-03-05 22:57:49.558580 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-05 22:57:49.558623 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.277186 2025-03-05 22:57:49.570392 | 2025-03-05 22:57:49.570490 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-05 22:57:49.636838 | ubuntu-noble | ok 2025-03-05 22:57:49.656403 | ubuntu-noble | included: /var/lib/zuul/builds/0279077655664662a8effc6245fe7152/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-05 22:57:49.666290 | 2025-03-05 22:57:49.666375 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-05 22:57:49.691680 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:49.698820 | 2025-03-05 22:57:49.698911 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-05 22:57:50.511260 | ubuntu-noble | changed 2025-03-05 22:57:50.520566 | 2025-03-05 22:57:50.520665 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-05 22:57:50.834367 | ubuntu-noble | ok 2025-03-05 22:57:50.843532 | 2025-03-05 22:57:50.843628 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-05 22:57:51.612492 | ubuntu-noble | changed 2025-03-05 22:57:51.618611 | 2025-03-05 22:57:51.618691 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-05 22:57:52.327823 | ubuntu-noble | changed 2025-03-05 22:57:52.334602 | 2025-03-05 22:57:52.334688 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-05 22:57:52.358118 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:52.365159 | 2025-03-05 22:57:52.365244 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-05 22:57:52.764287 | ubuntu-noble -> localhost | changed 2025-03-05 22:57:52.803155 | 2025-03-05 22:57:52.803266 | TASK [add-build-sshkey : Add back temp key] 2025-03-05 22:57:53.307004 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0279077655664662a8effc6245fe7152/work/0279077655664662a8effc6245fe7152_id_rsa (zuul-build-sshkey) 2025-03-05 22:57:53.307278 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017664 2025-03-05 22:57:53.315713 | 2025-03-05 22:57:53.315812 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-05 22:57:53.846526 | ubuntu-noble | ok 2025-03-05 22:57:53.859624 | 2025-03-05 22:57:53.859738 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-05 22:57:53.914000 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 22:57:53.928098 | 2025-03-05 22:57:53.928194 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-05 22:57:54.487333 | ubuntu-noble | ok 2025-03-05 22:57:54.499706 | 2025-03-05 22:57:54.499806 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-05 22:57:54.540145 | ubuntu-noble | ok 2025-03-05 22:57:54.546434 | 2025-03-05 22:57:54.546529 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-05 22:57:54.879921 | ubuntu-noble -> localhost | ok 2025-03-05 22:57:54.891552 | 2025-03-05 22:57:54.891642 | TASK [validate-host : Collect information about the host] 2025-03-05 22:57:56.199065 | ubuntu-noble | ok 2025-03-05 22:57:56.235005 | 2025-03-05 22:57:56.235119 | TASK [validate-host : Sanitize hostname] 2025-03-05 22:57:56.349309 | ubuntu-noble | ok 2025-03-05 22:57:56.355314 | 2025-03-05 22:57:56.355409 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-05 22:57:57.212850 | ubuntu-noble -> localhost | changed 2025-03-05 22:57:57.219603 | 2025-03-05 22:57:57.219694 | TASK [validate-host : Collect information about zuul worker] 2025-03-05 22:57:57.827021 | ubuntu-noble | ok 2025-03-05 22:57:57.833122 | 2025-03-05 22:57:57.833218 | TASK [validate-host : Write out all zuul information for each host] 2025-03-05 22:57:58.878536 | ubuntu-noble -> localhost | changed 2025-03-05 22:57:58.912558 | 2025-03-05 22:57:58.912672 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-05 22:57:59.257107 | ubuntu-noble | ok 2025-03-05 22:57:59.266617 | 2025-03-05 22:57:59.266699 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-05 22:58:00.309845 | ubuntu-noble | changed: 2025-03-05 22:58:00.310024 | ubuntu-noble | cd+++++++++ src/ 2025-03-05 22:58:00.310058 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-05 22:58:00.310083 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-05 22:58:00.310106 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-03-05 22:58:00.310127 | ubuntu-noble | Containerfile 2025-03-05 22:58:00.310285 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.010605 2025-03-05 22:59:11.494386 | 2025-03-05 22:59:11.494508 | TASK [upload-logs : Upload logs to log server] 2025-03-05 22:59:12.061648 | localhost | Output suppressed because no_log was given 2025-03-05 22:59:12.064997 | 2025-03-05 22:59:12.065102 | LOOP [upload-logs : Compress console log and json output] 2025-03-05 22:59:12.146072 | localhost | skipping: Conditional result was False 2025-03-05 22:59:12.166271 | localhost | skipping: Conditional result was False 2025-03-05 22:59:12.174559 | 2025-03-05 22:59:12.174674 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-05 22:59:12.239072 | localhost | skipping: Conditional result was False 2025-03-05 22:59:12.239397 | 2025-03-05 22:59:12.254756 | localhost | skipping: Conditional result was False 2025-03-05 22:59:12.270753 | 2025-03-05 22:59:12.270951 | LOOP [upload-logs : Upload console log and json output]