2025-01-23 00:06:08.652638 | Job console starting... 2025-01-23 00:06:08.671933 | Updating repositories 2025-01-23 00:06:08.701882 | Preparing job workspace 2025-01-23 00:06:11.432168 | Running Ansible setup... 2025-01-23 00:06:16.744899 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-23 00:06:17.516739 | 2025-01-23 00:06:17.516909 | PLAY [Base pre] 2025-01-23 00:06:17.550692 | 2025-01-23 00:06:17.550857 | TASK [Setup log path fact] 2025-01-23 00:06:17.584073 | ubuntu-noble | ok 2025-01-23 00:06:17.607233 | 2025-01-23 00:06:17.607397 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-23 00:06:17.659241 | ubuntu-noble | ok 2025-01-23 00:06:17.666182 | 2025-01-23 00:06:17.666313 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-23 00:06:17.701467 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:17.708973 | 2025-01-23 00:06:17.709104 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-23 00:06:17.754063 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:17.763318 | 2025-01-23 00:06:17.763457 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-23 00:06:17.793056 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:17.800751 | 2025-01-23 00:06:17.800881 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-23 00:06:17.825629 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:17.833799 | 2025-01-23 00:06:17.833930 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-23 00:06:17.858985 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:17.878440 | 2025-01-23 00:06:17.878591 | TASK [emit-job-header : Print job information] 2025-01-23 00:06:17.932546 | # Job Information 2025-01-23 00:06:17.932754 | Ansible Version: 2.15.3 2025-01-23 00:06:17.932786 | Job: ansible-lint 2025-01-23 00:06:17.932817 | Pipeline: check 2025-01-23 00:06:17.932838 | Executor: 7d211f194f6a 2025-01-23 00:06:17.932858 | Triggered by: https://github.com/osism/testbed/pull/2595 2025-01-23 00:06:17.932876 | Event ID: d3d64a50-d91d-11ef-83bc-9e07bfc4406b 2025-01-23 00:06:17.939955 | 2025-01-23 00:06:17.940081 | LOOP [emit-job-header : Print node information] 2025-01-23 00:06:18.091236 | ubuntu-noble | ok: 2025-01-23 00:06:18.091773 | ubuntu-noble | # Node Information 2025-01-23 00:06:18.091819 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-23 00:06:18.091846 | ubuntu-noble | Hostname: ubuntu 2025-01-23 00:06:18.091870 | ubuntu-noble | Username: zuul 2025-01-23 00:06:18.091891 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-23 00:06:18.091912 | ubuntu-noble | Provider: regiocloud-a 2025-01-23 00:06:18.091932 | ubuntu-noble | Label: ubuntu-noble 2025-01-23 00:06:18.091953 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-23 00:06:18.091975 | ubuntu-noble | Interface IP: 81.163.192.104 2025-01-23 00:06:18.117229 | 2025-01-23 00:06:18.120163 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-23 00:06:18.617828 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:18.633605 | 2025-01-23 00:06:18.633740 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-23 00:06:19.918874 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:19.950450 | 2025-01-23 00:06:19.950616 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-23 00:06:20.282521 | ubuntu-noble -> localhost | ok 2025-01-23 00:06:20.296320 | 2025-01-23 00:06:20.296479 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-23 00:06:20.328995 | ubuntu-noble | ok 2025-01-23 00:06:20.347726 | ubuntu-noble | included: /var/lib/zuul/builds/89590e5aff614d768a191df304824469/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-23 00:06:20.356093 | 2025-01-23 00:06:20.356221 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-23 00:06:21.300322 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-23 00:06:21.300578 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/89590e5aff614d768a191df304824469/work/89590e5aff614d768a191df304824469_id_rsa 2025-01-23 00:06:21.300619 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/89590e5aff614d768a191df304824469/work/89590e5aff614d768a191df304824469_id_rsa.pub 2025-01-23 00:06:21.300645 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-23 00:06:21.300670 | ubuntu-noble -> localhost | SHA256:C9rLJ8DYu4orpxtDruICinCn8PFvjAqLr5VE3jSuvok zuul-build-sshkey 2025-01-23 00:06:21.300693 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-23 00:06:21.300720 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-23 00:06:21.300742 | ubuntu-noble -> localhost | | | 2025-01-23 00:06:21.300764 | ubuntu-noble -> localhost | | | 2025-01-23 00:06:21.300784 | ubuntu-noble -> localhost | | . o | 2025-01-23 00:06:21.300804 | ubuntu-noble -> localhost | | o + . | 2025-01-23 00:06:21.300825 | ubuntu-noble -> localhost | | .o+o . S | 2025-01-23 00:06:21.300845 | ubuntu-noble -> localhost | |*.+o=o . . | 2025-01-23 00:06:21.300865 | ubuntu-noble -> localhost | |O=+=.=. . | 2025-01-23 00:06:21.300886 | ubuntu-noble -> localhost | |OX+.+.+.. | 2025-01-23 00:06:21.300906 | ubuntu-noble -> localhost | |EOB+.++o | 2025-01-23 00:06:21.300926 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-23 00:06:21.300978 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.379997 2025-01-23 00:06:21.309367 | 2025-01-23 00:06:21.309488 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-23 00:06:21.342851 | ubuntu-noble | ok 2025-01-23 00:06:21.354494 | ubuntu-noble | included: /var/lib/zuul/builds/89590e5aff614d768a191df304824469/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-23 00:06:21.364689 | 2025-01-23 00:06:21.364813 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-23 00:06:21.391905 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.399707 | 2025-01-23 00:06:21.399838 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-23 00:06:22.088192 | ubuntu-noble | changed 2025-01-23 00:06:22.102242 | 2025-01-23 00:06:22.102440 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-23 00:06:22.353674 | ubuntu-noble | ok 2025-01-23 00:06:22.369464 | 2025-01-23 00:06:22.369663 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-23 00:06:23.049520 | ubuntu-noble | changed 2025-01-23 00:06:23.057207 | 2025-01-23 00:06:23.057334 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-23 00:06:23.754353 | ubuntu-noble | changed 2025-01-23 00:06:23.770965 | 2025-01-23 00:06:23.771105 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-23 00:06:23.796664 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:23.804959 | 2025-01-23 00:06:23.805196 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-23 00:06:24.307463 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:24.321968 | 2025-01-23 00:06:24.322096 | TASK [add-build-sshkey : Add back temp key] 2025-01-23 00:06:24.699475 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/89590e5aff614d768a191df304824469/work/89590e5aff614d768a191df304824469_id_rsa (zuul-build-sshkey) 2025-01-23 00:06:24.699731 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010134 2025-01-23 00:06:24.711867 | 2025-01-23 00:06:24.712001 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-23 00:06:25.158142 | ubuntu-noble | ok 2025-01-23 00:06:25.170843 | 2025-01-23 00:06:25.171024 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-23 00:06:25.214547 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:25.229895 | 2025-01-23 00:06:25.230034 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-23 00:06:25.635041 | ubuntu-noble | ok 2025-01-23 00:06:25.654560 | 2025-01-23 00:06:25.654708 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-23 00:06:25.689543 | ubuntu-noble | ok 2025-01-23 00:06:25.697246 | 2025-01-23 00:06:25.697361 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-23 00:06:25.992631 | ubuntu-noble -> localhost | ok 2025-01-23 00:06:26.004614 | 2025-01-23 00:06:26.004785 | TASK [validate-host : Collect information about the host] 2025-01-23 00:06:27.125969 | ubuntu-noble | ok 2025-01-23 00:06:27.141340 | 2025-01-23 00:06:27.141480 | TASK [validate-host : Sanitize hostname] 2025-01-23 00:06:27.223536 | ubuntu-noble | ok 2025-01-23 00:06:27.233086 | 2025-01-23 00:06:27.233256 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-23 00:06:27.852249 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:27.860601 | 2025-01-23 00:06:27.860730 | TASK [validate-host : Collect information about zuul worker] 2025-01-23 00:06:28.365581 | ubuntu-noble | ok 2025-01-23 00:06:28.372615 | 2025-01-23 00:06:28.372741 | TASK [validate-host : Write out all zuul information for each host] 2025-01-23 00:06:28.999889 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:29.012603 | 2025-01-23 00:06:29.012749 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-23 00:06:29.326639 | ubuntu-noble | ok 2025-01-23 00:06:29.336414 | 2025-01-23 00:06:29.336564 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-23 00:06:30.769024 | ubuntu-noble | changed: 2025-01-23 00:06:30.769250 | ubuntu-noble | cd+++++++++ src/ 2025-01-23 00:06:30.769285 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-23 00:06:30.769308 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-23 00:06:30.769331 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-23 00:06:30.769351 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009463 2025-01-23 00:07:51.947421 | 2025-01-23 00:07:51.947638 | TASK [upload-logs : Upload logs to log server] 2025-01-23 00:07:52.546175 | localhost | Output suppressed because no_log was given 2025-01-23 00:07:52.554774 | 2025-01-23 00:07:52.554915 | LOOP [upload-logs : Compress console log and json output] 2025-01-23 00:07:52.630126 | localhost | skipping: Conditional result was False 2025-01-23 00:07:52.648665 | localhost | skipping: Conditional result was False 2025-01-23 00:07:52.656425 | 2025-01-23 00:07:52.656569 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-23 00:07:52.724883 | localhost | skipping: Conditional result was False 2025-01-23 00:07:52.725362 | 2025-01-23 00:07:52.737949 | localhost | skipping: Conditional result was False 2025-01-23 00:07:52.747225 | 2025-01-23 00:07:52.747342 | LOOP [upload-logs : Upload console log and json output]