2025-02-19 14:44:43.174950 | Job console starting... 2025-02-19 14:44:43.222269 | Updating repositories 2025-02-19 14:44:43.283196 | Preparing job workspace 2025-02-19 14:44:45.323262 | Running Ansible setup... 2025-02-19 14:44:51.756246 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-19 14:44:52.732094 | 2025-02-19 14:44:52.732273 | PLAY [Base pre] 2025-02-19 14:44:52.763016 | 2025-02-19 14:44:52.763170 | TASK [Setup log path fact] 2025-02-19 14:44:52.805038 | ubuntu-noble | ok 2025-02-19 14:44:52.845596 | 2025-02-19 14:44:52.845761 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-19 14:44:52.904961 | ubuntu-noble | ok 2025-02-19 14:44:52.917067 | 2025-02-19 14:44:52.917200 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-19 14:44:52.972624 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:52.980010 | 2025-02-19 14:44:52.980146 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-19 14:44:53.046934 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:53.055392 | 2025-02-19 14:44:53.055542 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-19 14:44:53.072959 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:53.080640 | 2025-02-19 14:44:53.080773 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-19 14:44:53.106650 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:53.114298 | 2025-02-19 14:44:53.114446 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-19 14:44:53.139265 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:53.160992 | 2025-02-19 14:44:53.161145 | TASK [emit-job-header : Print job information] 2025-02-19 14:44:53.266642 | # Job Information 2025-02-19 14:44:53.266836 | Ansible Version: 2.15.3 2025-02-19 14:44:53.266868 | Job: python-black 2025-02-19 14:44:53.266897 | Pipeline: check 2025-02-19 14:44:53.266918 | Executor: 7d211f194f6a 2025-02-19 14:44:53.266937 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/211 2025-02-19 14:44:53.266956 | Event ID: 09184b10-eed0-11ef-92fb-08cbc474d113 2025-02-19 14:44:53.273883 | 2025-02-19 14:44:53.274016 | LOOP [emit-job-header : Print node information] 2025-02-19 14:44:53.495019 | ubuntu-noble | ok: 2025-02-19 14:44:53.495219 | ubuntu-noble | # Node Information 2025-02-19 14:44:53.495251 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-19 14:44:53.495275 | ubuntu-noble | Hostname: ubuntu 2025-02-19 14:44:53.495297 | ubuntu-noble | Username: zuul 2025-02-19 14:44:53.495317 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-19 14:44:53.495372 | ubuntu-noble | Provider: regiocloud-a 2025-02-19 14:44:53.495394 | ubuntu-noble | Label: ubuntu-noble 2025-02-19 14:44:53.495414 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-19 14:44:53.495435 | ubuntu-noble | Interface IP: 81.163.192.208 2025-02-19 14:44:53.537132 | 2025-02-19 14:44:53.537281 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-19 14:44:54.062011 | ubuntu-noble -> localhost | changed 2025-02-19 14:44:54.070945 | 2025-02-19 14:44:54.071079 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-19 14:44:55.523489 | ubuntu-noble -> localhost | changed 2025-02-19 14:44:55.539931 | 2025-02-19 14:44:55.540072 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-19 14:44:55.960179 | ubuntu-noble -> localhost | ok 2025-02-19 14:44:55.968160 | 2025-02-19 14:44:55.968288 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-19 14:44:55.999649 | ubuntu-noble | ok 2025-02-19 14:44:56.031288 | ubuntu-noble | included: /var/lib/zuul/builds/4cc5f5c8576649779e4f5348904b9044/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-19 14:44:56.047622 | 2025-02-19 14:44:56.047731 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-19 14:44:56.606130 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-19 14:44:56.606326 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4cc5f5c8576649779e4f5348904b9044/work/4cc5f5c8576649779e4f5348904b9044_id_rsa 2025-02-19 14:44:56.606376 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4cc5f5c8576649779e4f5348904b9044/work/4cc5f5c8576649779e4f5348904b9044_id_rsa.pub 2025-02-19 14:44:56.606403 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-19 14:44:56.606426 | ubuntu-noble -> localhost | SHA256:xv85L4ytiCUWMIrZ/txchCEjGxZBysv8wN1DawxZCBE zuul-build-sshkey 2025-02-19 14:44:56.606449 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-19 14:44:56.606473 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-19 14:44:56.606495 | ubuntu-noble -> localhost | | EB... | 2025-02-19 14:44:56.606514 | ubuntu-noble -> localhost | |.. oo | 2025-02-19 14:44:56.606534 | ubuntu-noble -> localhost | |..+o=.. | 2025-02-19 14:44:56.606552 | ubuntu-noble -> localhost | |+=o===.+ | 2025-02-19 14:44:56.606571 | ubuntu-noble -> localhost | |o*+. *o S | 2025-02-19 14:44:56.606591 | ubuntu-noble -> localhost | | .o . .+ . | 2025-02-19 14:44:56.606609 | ubuntu-noble -> localhost | | .. o o .+ | 2025-02-19 14:44:56.606629 | ubuntu-noble -> localhost | | o + = ...=. | 2025-02-19 14:44:56.606647 | ubuntu-noble -> localhost | | o + . ..o+. | 2025-02-19 14:44:56.606666 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-19 14:44:56.606710 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.069907 2025-02-19 14:44:56.615407 | 2025-02-19 14:44:56.615515 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-19 14:44:56.644887 | ubuntu-noble | ok 2025-02-19 14:44:56.655583 | ubuntu-noble | included: /var/lib/zuul/builds/4cc5f5c8576649779e4f5348904b9044/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-19 14:44:56.665111 | 2025-02-19 14:44:56.665203 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-19 14:44:56.679472 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:56.686606 | 2025-02-19 14:44:56.686693 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-19 14:44:57.469639 | ubuntu-noble | changed 2025-02-19 14:44:57.480263 | 2025-02-19 14:44:57.480410 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-19 14:44:57.797492 | ubuntu-noble | ok 2025-02-19 14:44:57.808352 | 2025-02-19 14:44:57.808564 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-19 14:44:58.567613 | ubuntu-noble | changed 2025-02-19 14:44:58.577212 | 2025-02-19 14:44:58.577355 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-19 14:44:59.312174 | ubuntu-noble | changed 2025-02-19 14:44:59.317837 | 2025-02-19 14:44:59.317916 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-19 14:44:59.369446 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:44:59.375744 | 2025-02-19 14:44:59.375833 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-19 14:44:59.839446 | ubuntu-noble -> localhost | changed 2025-02-19 14:44:59.852615 | 2025-02-19 14:44:59.852729 | TASK [add-build-sshkey : Add back temp key] 2025-02-19 14:45:00.243524 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4cc5f5c8576649779e4f5348904b9044/work/4cc5f5c8576649779e4f5348904b9044_id_rsa (zuul-build-sshkey) 2025-02-19 14:45:00.244039 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016215 2025-02-19 14:45:00.284755 | 2025-02-19 14:45:00.284860 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-19 14:45:00.737043 | ubuntu-noble | ok 2025-02-19 14:45:00.744583 | 2025-02-19 14:45:00.744688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-19 14:45:00.768249 | ubuntu-noble | skipping: Conditional result was False 2025-02-19 14:45:00.781082 | 2025-02-19 14:45:00.781179 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-19 14:45:01.196118 | ubuntu-noble | ok 2025-02-19 14:45:01.213483 | 2025-02-19 14:45:01.213596 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-19 14:45:01.253701 | ubuntu-noble | ok 2025-02-19 14:45:01.260020 | 2025-02-19 14:45:01.260114 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-19 14:45:01.509220 | ubuntu-noble -> localhost | ok 2025-02-19 14:45:01.516741 | 2025-02-19 14:45:01.516835 | TASK [validate-host : Collect information about the host] 2025-02-19 14:45:02.749996 | ubuntu-noble | ok 2025-02-19 14:45:02.776805 | 2025-02-19 14:45:02.776926 | TASK [validate-host : Sanitize hostname] 2025-02-19 14:45:02.856921 | ubuntu-noble | ok 2025-02-19 14:45:02.863006 | 2025-02-19 14:45:02.863102 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-19 14:45:03.414862 | ubuntu-noble -> localhost | changed 2025-02-19 14:45:03.421652 | 2025-02-19 14:45:03.421752 | TASK [validate-host : Collect information about zuul worker] 2025-02-19 14:45:03.906741 | ubuntu-noble | ok 2025-02-19 14:45:03.916053 | 2025-02-19 14:45:03.916326 | TASK [validate-host : Write out all zuul information for each host] 2025-02-19 14:45:04.430290 | ubuntu-noble -> localhost | changed 2025-02-19 14:45:04.443104 | 2025-02-19 14:45:04.443221 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-19 14:45:04.784496 | ubuntu-noble | ok 2025-02-19 14:45:04.791505 | 2025-02-19 14:45:04.791622 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-19 14:45:05.811749 | ubuntu-noble | changed: 2025-02-19 14:45:05.811954 | ubuntu-noble | cd+++++++++ src/ 2025-02-19 14:45:05.811987 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-19 14:45:05.812010 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-19 14:45:05.812030 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-02-19 14:45:05.812050 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.028726 2025-02-19 14:45:39.665879 | 2025-02-19 14:45:39.665990 | TASK [upload-logs : Upload logs to log server] 2025-02-19 14:45:40.263906 | localhost | Output suppressed because no_log was given 2025-02-19 14:45:40.268541 | 2025-02-19 14:45:40.268673 | LOOP [upload-logs : Compress console log and json output] 2025-02-19 14:45:40.333513 | localhost | skipping: Conditional result was False 2025-02-19 14:45:40.351105 | localhost | skipping: Conditional result was False 2025-02-19 14:45:40.365635 | 2025-02-19 14:45:40.365807 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-19 14:45:40.435099 | localhost | skipping: Conditional result was False 2025-02-19 14:45:40.435431 | 2025-02-19 14:45:40.450479 | localhost | skipping: Conditional result was False 2025-02-19 14:45:40.462231 | 2025-02-19 14:45:40.462444 | LOOP [upload-logs : Upload console log and json output]