2025-02-25 23:26:06.388922 | Job console starting... 2025-02-25 23:26:06.400051 | Updating repositories 2025-02-25 23:26:06.430904 | Preparing job workspace 2025-02-25 23:26:08.918289 | Running Ansible setup... 2025-02-25 23:26:15.110290 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 23:26:15.766485 | 2025-02-25 23:26:15.766619 | PLAY [Base pre] 2025-02-25 23:26:15.794106 | 2025-02-25 23:26:15.794228 | TASK [Setup log path fact] 2025-02-25 23:26:15.835076 | ubuntu-noble | ok 2025-02-25 23:26:15.857122 | 2025-02-25 23:26:15.857241 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:26:15.927639 | ubuntu-noble | ok 2025-02-25 23:26:15.938093 | 2025-02-25 23:26:15.938203 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:26:15.996178 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.003494 | 2025-02-25 23:26:16.003624 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:26:16.057646 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.065717 | 2025-02-25 23:26:16.065815 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:26:16.089404 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.096303 | 2025-02-25 23:26:16.096411 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:26:16.119786 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.126803 | 2025-02-25 23:26:16.126893 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:26:16.140714 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.155151 | 2025-02-25 23:26:16.155253 | TASK [emit-job-header : Print job information] 2025-02-25 23:26:16.205591 | # Job Information 2025-02-25 23:26:16.205739 | Ansible Version: 2.15.3 2025-02-25 23:26:16.205771 | Job: ansible-collection-ensure-readme 2025-02-25 23:26:16.205800 | Pipeline: check 2025-02-25 23:26:16.205821 | Executor: 7d211f194f6a 2025-02-25 23:26:16.205841 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1769 2025-02-25 23:26:16.205861 | Event ID: c4ddac60-f3ca-11ef-9b50-8b7254e7429b 2025-02-25 23:26:16.211909 | 2025-02-25 23:26:16.211992 | LOOP [emit-job-header : Print node information] 2025-02-25 23:26:16.372111 | ubuntu-noble | ok: 2025-02-25 23:26:16.372346 | ubuntu-noble | # Node Information 2025-02-25 23:26:16.372409 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 23:26:16.372437 | ubuntu-noble | Hostname: ubuntu 2025-02-25 23:26:16.372459 | ubuntu-noble | Username: zuul 2025-02-25 23:26:16.372479 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 23:26:16.372499 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 23:26:16.372518 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 23:26:16.372537 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 23:26:16.372579 | ubuntu-noble | Interface IP: 81.163.192.90 2025-02-25 23:26:16.392487 | 2025-02-25 23:26:16.392607 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 23:26:17.046982 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:17.053607 | 2025-02-25 23:26:17.053690 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 23:26:18.304104 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:18.317227 | 2025-02-25 23:26:18.317339 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 23:26:18.716846 | ubuntu-noble -> localhost | ok 2025-02-25 23:26:18.723465 | 2025-02-25 23:26:18.723569 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 23:26:18.753689 | ubuntu-noble | ok 2025-02-25 23:26:18.779445 | ubuntu-noble | included: /var/lib/zuul/builds/545988ff743d4fada5985cea97794c5c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 23:26:18.787043 | 2025-02-25 23:26:18.787135 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 23:26:19.633364 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 23:26:19.633524 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/545988ff743d4fada5985cea97794c5c/work/545988ff743d4fada5985cea97794c5c_id_rsa 2025-02-25 23:26:19.633553 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/545988ff743d4fada5985cea97794c5c/work/545988ff743d4fada5985cea97794c5c_id_rsa.pub 2025-02-25 23:26:19.633586 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 23:26:19.633606 | ubuntu-noble -> localhost | SHA256:lnaiQk40O6gDuaMBqbzq4qDh9YrQaG5JDzhIEDM0BZY zuul-build-sshkey 2025-02-25 23:26:19.633624 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 23:26:19.633644 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 23:26:19.633661 | ubuntu-noble -> localhost | |=*+. | 2025-02-25 23:26:19.633677 | ubuntu-noble -> localhost | |oE. | 2025-02-25 23:26:19.633693 | ubuntu-noble -> localhost | |. o | 2025-02-25 23:26:19.633708 | ubuntu-noble -> localhost | | + o o . | 2025-02-25 23:26:19.633723 | ubuntu-noble -> localhost | |O . = S . | 2025-02-25 23:26:19.633738 | ubuntu-noble -> localhost | |OB + . + o | 2025-02-25 23:26:19.633754 | ubuntu-noble -> localhost | |&+=.o . | 2025-02-25 23:26:19.633770 | ubuntu-noble -> localhost | |XB+... | 2025-02-25 23:26:19.633786 | ubuntu-noble -> localhost | |XB ... | 2025-02-25 23:26:19.633801 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 23:26:19.633837 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.274326 2025-02-25 23:26:19.640950 | 2025-02-25 23:26:19.641034 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 23:26:19.669320 | ubuntu-noble | ok 2025-02-25 23:26:19.678161 | ubuntu-noble | included: /var/lib/zuul/builds/545988ff743d4fada5985cea97794c5c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 23:26:19.686262 | 2025-02-25 23:26:19.686340 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 23:26:19.720596 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:19.726636 | 2025-02-25 23:26:19.726721 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 23:26:20.495981 | ubuntu-noble | changed 2025-02-25 23:26:20.508040 | 2025-02-25 23:26:20.508145 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 23:26:20.861496 | ubuntu-noble | ok 2025-02-25 23:26:20.871262 | 2025-02-25 23:26:20.871370 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 23:26:21.658071 | ubuntu-noble | changed 2025-02-25 23:26:21.664757 | 2025-02-25 23:26:21.664846 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 23:26:22.403012 | ubuntu-noble | changed 2025-02-25 23:26:22.413870 | 2025-02-25 23:26:22.414082 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 23:26:22.448719 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:22.455706 | 2025-02-25 23:26:22.455793 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 23:26:22.856303 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:22.869312 | 2025-02-25 23:26:22.869409 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 23:26:23.272374 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/545988ff743d4fada5985cea97794c5c/work/545988ff743d4fada5985cea97794c5c_id_rsa (zuul-build-sshkey) 2025-02-25 23:26:23.272614 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007953 2025-02-25 23:26:23.305604 | 2025-02-25 23:26:23.305712 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 23:26:23.731387 | ubuntu-noble | ok 2025-02-25 23:26:23.740490 | 2025-02-25 23:26:23.740765 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 23:26:23.775185 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:23.796427 | 2025-02-25 23:26:23.796530 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 23:26:24.231719 | ubuntu-noble | ok 2025-02-25 23:26:24.249408 | 2025-02-25 23:26:24.249505 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 23:26:24.298120 | ubuntu-noble | ok 2025-02-25 23:26:24.304340 | 2025-02-25 23:26:24.304443 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 23:26:24.572469 | ubuntu-noble -> localhost | ok 2025-02-25 23:26:24.580006 | 2025-02-25 23:26:24.580093 | TASK [validate-host : Collect information about the host] 2025-02-25 23:26:25.806526 | ubuntu-noble | ok 2025-02-25 23:26:25.818672 | 2025-02-25 23:26:25.818773 | TASK [validate-host : Sanitize hostname] 2025-02-25 23:26:25.878353 | ubuntu-noble | ok 2025-02-25 23:26:25.884187 | 2025-02-25 23:26:25.884276 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 23:26:26.371433 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:26.386347 | 2025-02-25 23:26:26.386484 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 23:26:26.864098 | ubuntu-noble | ok 2025-02-25 23:26:26.874388 | 2025-02-25 23:26:26.874507 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 23:26:27.471390 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:27.484255 | 2025-02-25 23:26:27.484371 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 23:26:27.840526 | ubuntu-noble | ok 2025-02-25 23:26:27.850000 | 2025-02-25 23:26:27.850120 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 23:26:29.093261 | ubuntu-noble | changed: 2025-02-25 23:26:29.093466 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 23:26:29.093498 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 23:26:29.093522 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 23:26:29.093544 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-25 23:26:29.093587 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005101 2025-02-25 23:26:49.386589 | 2025-02-25 23:26:49.386708 | TASK [upload-logs : Upload logs to log server] 2025-02-25 23:26:49.992908 | localhost | Output suppressed because no_log was given 2025-02-25 23:26:49.999026 | 2025-02-25 23:26:49.999176 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 23:26:50.084671 | localhost | skipping: Conditional result was False 2025-02-25 23:26:50.102296 | localhost | skipping: Conditional result was False 2025-02-25 23:26:50.115740 | 2025-02-25 23:26:50.115908 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 23:26:50.181180 | localhost | skipping: Conditional result was False 2025-02-25 23:26:50.181521 | 2025-02-25 23:26:50.194129 | localhost | skipping: Conditional result was False 2025-02-25 23:26:50.203424 | 2025-02-25 23:26:50.203625 | LOOP [upload-logs : Upload console log and json output]