2025-02-05 18:37:45.246115 | Job console starting... 2025-02-05 18:37:45.259665 | Updating repositories 2025-02-05 18:37:45.296983 | Preparing job workspace 2025-02-05 18:37:46.761174 | Running Ansible setup... 2025-02-05 18:37:51.973948 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-05 18:37:52.711025 | 2025-02-05 18:37:52.711181 | PLAY [Base pre] 2025-02-05 18:37:52.741646 | 2025-02-05 18:37:52.741794 | TASK [Setup log path fact] 2025-02-05 18:37:52.783292 | ubuntu-noble | ok 2025-02-05 18:37:52.809784 | 2025-02-05 18:37:52.809984 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 18:37:52.880614 | ubuntu-noble | ok 2025-02-05 18:37:52.895874 | 2025-02-05 18:37:52.895999 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 18:37:52.953260 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:52.969751 | 2025-02-05 18:37:52.969994 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 18:37:53.028753 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:53.044019 | 2025-02-05 18:37:53.044175 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 18:37:53.069906 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:53.080001 | 2025-02-05 18:37:53.080132 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 18:37:53.115434 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:53.128230 | 2025-02-05 18:37:53.128433 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 18:37:53.155684 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:53.182717 | 2025-02-05 18:37:53.182865 | TASK [emit-job-header : Print job information] 2025-02-05 18:37:53.255266 | # Job Information 2025-02-05 18:37:53.255541 | Ansible Version: 2.15.3 2025-02-05 18:37:53.255597 | Job: flake8 2025-02-05 18:37:53.255650 | Pipeline: check 2025-02-05 18:37:53.255686 | Executor: 7d211f194f6a 2025-02-05 18:37:53.255719 | Triggered by: https://github.com/osism/python-osism/pull/1195 2025-02-05 18:37:53.255752 | Event ID: f8a50d30-e3ef-11ef-83b9-d0c3b989914d 2025-02-05 18:37:53.265632 | 2025-02-05 18:37:53.265763 | LOOP [emit-job-header : Print node information] 2025-02-05 18:37:53.421463 | ubuntu-noble | ok: 2025-02-05 18:37:53.421721 | ubuntu-noble | # Node Information 2025-02-05 18:37:53.421928 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-05 18:37:53.421987 | ubuntu-noble | Hostname: ubuntu 2025-02-05 18:37:53.422026 | ubuntu-noble | Username: zuul 2025-02-05 18:37:53.422062 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-05 18:37:53.422097 | ubuntu-noble | Provider: regiocloud-a 2025-02-05 18:37:53.422130 | ubuntu-noble | Label: ubuntu-noble 2025-02-05 18:37:53.422162 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-05 18:37:53.422196 | ubuntu-noble | Interface IP: 81.163.192.64 2025-02-05 18:37:53.446267 | 2025-02-05 18:37:53.446403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-05 18:37:53.942398 | ubuntu-noble -> localhost | changed 2025-02-05 18:37:53.964888 | 2025-02-05 18:37:53.965016 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-05 18:37:55.088861 | ubuntu-noble -> localhost | changed 2025-02-05 18:37:55.102765 | 2025-02-05 18:37:55.102922 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-05 18:37:55.412655 | ubuntu-noble -> localhost | ok 2025-02-05 18:37:55.421742 | 2025-02-05 18:37:55.421898 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-05 18:37:55.452773 | ubuntu-noble | ok 2025-02-05 18:37:55.469366 | ubuntu-noble | included: /var/lib/zuul/builds/46fc3e2b1626410e8a2b051e5dae42f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-05 18:37:55.477194 | 2025-02-05 18:37:55.477298 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-05 18:37:56.832197 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-05 18:37:56.832460 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/46fc3e2b1626410e8a2b051e5dae42f7/work/46fc3e2b1626410e8a2b051e5dae42f7_id_rsa 2025-02-05 18:37:56.832503 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/46fc3e2b1626410e8a2b051e5dae42f7/work/46fc3e2b1626410e8a2b051e5dae42f7_id_rsa.pub 2025-02-05 18:37:56.832529 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-05 18:37:56.832553 | ubuntu-noble -> localhost | SHA256:5+//mI8/g//vvJrh7oqpTijwNO97JeSMfVmWSgqsECk zuul-build-sshkey 2025-02-05 18:37:56.832576 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-05 18:37:56.832602 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-05 18:37:56.832624 | ubuntu-noble -> localhost | | . | 2025-02-05 18:37:56.832645 | ubuntu-noble -> localhost | |Eo | 2025-02-05 18:37:56.832666 | ubuntu-noble -> localhost | |. . . . | 2025-02-05 18:37:56.832687 | ubuntu-noble -> localhost | | . o . . + | 2025-02-05 18:37:56.832706 | ubuntu-noble -> localhost | | ..o. B S * | 2025-02-05 18:37:56.832726 | ubuntu-noble -> localhost | | +.o..* B | 2025-02-05 18:37:56.832746 | ubuntu-noble -> localhost | | o o .+ . .. | 2025-02-05 18:37:56.832766 | ubuntu-noble -> localhost | | o .. o...oB | 2025-02-05 18:37:56.832787 | ubuntu-noble -> localhost | | o+o.o o*BBB#| 2025-02-05 18:37:56.832808 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-05 18:37:56.832878 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.828912 2025-02-05 18:37:56.841991 | 2025-02-05 18:37:56.842117 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-05 18:37:56.882126 | ubuntu-noble | ok 2025-02-05 18:37:56.897173 | ubuntu-noble | included: /var/lib/zuul/builds/46fc3e2b1626410e8a2b051e5dae42f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-05 18:37:56.907073 | 2025-02-05 18:37:56.907179 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-05 18:37:56.937663 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:56.950009 | 2025-02-05 18:37:56.950154 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-05 18:37:57.711072 | ubuntu-noble | changed 2025-02-05 18:37:57.720977 | 2025-02-05 18:37:57.721087 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-05 18:37:58.039265 | ubuntu-noble | ok 2025-02-05 18:37:58.050397 | 2025-02-05 18:37:58.050536 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-05 18:37:58.798704 | ubuntu-noble | changed 2025-02-05 18:37:58.808335 | 2025-02-05 18:37:58.808484 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-05 18:37:59.520336 | ubuntu-noble | changed 2025-02-05 18:37:59.530950 | 2025-02-05 18:37:59.531079 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-05 18:37:59.566838 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:37:59.583719 | 2025-02-05 18:37:59.583888 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-05 18:38:00.059120 | ubuntu-noble -> localhost | changed 2025-02-05 18:38:00.072963 | 2025-02-05 18:38:00.073073 | TASK [add-build-sshkey : Add back temp key] 2025-02-05 18:38:00.478564 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/46fc3e2b1626410e8a2b051e5dae42f7/work/46fc3e2b1626410e8a2b051e5dae42f7_id_rsa (zuul-build-sshkey) 2025-02-05 18:38:00.478867 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016416 2025-02-05 18:38:00.519777 | 2025-02-05 18:38:00.519919 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-05 18:38:00.919514 | ubuntu-noble | ok 2025-02-05 18:38:00.928541 | 2025-02-05 18:38:00.928666 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-05 18:38:00.964548 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 18:38:00.988433 | 2025-02-05 18:38:00.988561 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-05 18:38:01.385173 | ubuntu-noble | ok 2025-02-05 18:38:01.401599 | 2025-02-05 18:38:01.401717 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-05 18:38:01.449242 | ubuntu-noble | ok 2025-02-05 18:38:01.460702 | 2025-02-05 18:38:01.460876 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-05 18:38:01.805564 | ubuntu-noble -> localhost | ok 2025-02-05 18:38:01.814359 | 2025-02-05 18:38:01.814468 | TASK [validate-host : Collect information about the host] 2025-02-05 18:38:02.893999 | ubuntu-noble | ok 2025-02-05 18:38:02.909110 | 2025-02-05 18:38:02.909787 | TASK [validate-host : Sanitize hostname] 2025-02-05 18:38:02.990611 | ubuntu-noble | ok 2025-02-05 18:38:03.000784 | 2025-02-05 18:38:03.000984 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-05 18:38:03.604069 | ubuntu-noble -> localhost | changed 2025-02-05 18:38:03.612948 | 2025-02-05 18:38:03.613072 | TASK [validate-host : Collect information about zuul worker] 2025-02-05 18:38:04.071633 | ubuntu-noble | ok 2025-02-05 18:38:04.082987 | 2025-02-05 18:38:04.083142 | TASK [validate-host : Write out all zuul information for each host] 2025-02-05 18:38:04.760771 | ubuntu-noble -> localhost | changed 2025-02-05 18:38:04.784044 | 2025-02-05 18:38:04.784173 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-05 18:38:05.044117 | ubuntu-noble | ok 2025-02-05 18:38:05.054672 | 2025-02-05 18:38:05.054831 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-05 18:38:06.520448 | ubuntu-noble | changed: 2025-02-05 18:38:06.520656 | ubuntu-noble | cd+++++++++ src/ 2025-02-05 18:38:06.520693 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-05 18:38:06.520719 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-05 18:38:06.520742 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-02-05 18:38:06.520764 | ubuntu-noble | Containerfile 2025-02-05 18:38:06.521078 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009121 2025-02-05 18:39:03.016615 | 2025-02-05 18:39:03.016790 | TASK [upload-logs : Upload logs to log server] 2025-02-05 18:39:03.592223 | localhost | Output suppressed because no_log was given 2025-02-05 18:39:03.598310 | 2025-02-05 18:39:03.598464 | LOOP [upload-logs : Compress console log and json output] 2025-02-05 18:39:03.668288 | localhost | skipping: Conditional result was False 2025-02-05 18:39:03.685310 | localhost | skipping: Conditional result was False 2025-02-05 18:39:03.689619 | 2025-02-05 18:39:03.689747 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-05 18:39:03.762718 | localhost | skipping: Conditional result was False 2025-02-05 18:39:03.763422 | 2025-02-05 18:39:03.774848 | localhost | skipping: Conditional result was False 2025-02-05 18:39:03.784686 | 2025-02-05 18:39:03.784903 | LOOP [upload-logs : Upload console log and json output]