2025-03-02 00:16:36.667207 | Job console starting... 2025-03-02 00:16:36.689750 | Updating repositories 2025-03-02 00:16:36.763331 | Preparing job workspace 2025-03-02 00:16:39.550042 | Running Ansible setup... 2025-03-02 00:16:45.714515 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-02 00:16:46.356721 | 2025-03-02 00:16:46.356825 | PLAY [Base pre] 2025-03-02 00:16:46.391359 | 2025-03-02 00:16:46.391447 | TASK [Setup log path fact] 2025-03-02 00:16:46.412721 | ubuntu-noble | ok 2025-03-02 00:16:46.430204 | 2025-03-02 00:16:46.430287 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 00:16:46.512056 | ubuntu-noble | ok 2025-03-02 00:16:46.525517 | 2025-03-02 00:16:46.525608 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 00:16:46.554146 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:46.560056 | 2025-03-02 00:16:46.560145 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 00:16:46.654215 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:46.660090 | 2025-03-02 00:16:46.660176 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 00:16:46.713476 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:46.719234 | 2025-03-02 00:16:46.719316 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 00:16:46.776853 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:46.792484 | 2025-03-02 00:16:46.793132 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 00:16:46.870711 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:46.889339 | 2025-03-02 00:16:46.889433 | TASK [emit-job-header : Print job information] 2025-03-02 00:16:46.979150 | # Job Information 2025-03-02 00:16:46.979281 | Ansible Version: 2.15.3 2025-03-02 00:16:46.979308 | Job: mypy 2025-03-02 00:16:46.979333 | Pipeline: check 2025-03-02 00:16:46.979350 | Executor: 7d211f194f6a 2025-03-02 00:16:46.979366 | Triggered by: https://github.com/osism/openstack-image-manager/pull/850 2025-03-02 00:16:46.979381 | Event ID: 95199280-f6fb-11ef-86e9-66272a0f6c1b 2025-03-02 00:16:46.996608 | 2025-03-02 00:16:46.996709 | LOOP [emit-job-header : Print node information] 2025-03-02 00:16:47.180056 | ubuntu-noble | ok: 2025-03-02 00:16:47.180194 | ubuntu-noble | # Node Information 2025-03-02 00:16:47.181074 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-02 00:16:47.181122 | ubuntu-noble | Hostname: ubuntu 2025-03-02 00:16:47.181144 | ubuntu-noble | Username: zuul 2025-03-02 00:16:47.181163 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-02 00:16:47.181180 | ubuntu-noble | Provider: regiocloud-a 2025-03-02 00:16:47.181197 | ubuntu-noble | Label: ubuntu-noble 2025-03-02 00:16:47.181213 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-02 00:16:47.181230 | ubuntu-noble | Interface IP: 81.163.192.14 2025-03-02 00:16:47.201433 | 2025-03-02 00:16:47.201518 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-02 00:16:47.642529 | ubuntu-noble -> localhost | changed 2025-03-02 00:16:47.649208 | 2025-03-02 00:16:47.649285 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-02 00:16:49.311414 | ubuntu-noble -> localhost | changed 2025-03-02 00:16:49.328638 | 2025-03-02 00:16:49.328734 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-02 00:16:49.666577 | ubuntu-noble -> localhost | ok 2025-03-02 00:16:49.672539 | 2025-03-02 00:16:49.672618 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-02 00:16:49.721581 | ubuntu-noble | ok 2025-03-02 00:16:49.742730 | ubuntu-noble | included: /var/lib/zuul/builds/1a319ee5dfa843a2889da0c8218d52e3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-02 00:16:49.756697 | 2025-03-02 00:16:49.756779 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-02 00:16:50.642029 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-02 00:16:50.642245 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1a319ee5dfa843a2889da0c8218d52e3/work/1a319ee5dfa843a2889da0c8218d52e3_id_rsa 2025-03-02 00:16:50.642280 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1a319ee5dfa843a2889da0c8218d52e3/work/1a319ee5dfa843a2889da0c8218d52e3_id_rsa.pub 2025-03-02 00:16:50.642301 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-02 00:16:50.642320 | ubuntu-noble -> localhost | SHA256:j3MmtZxSj7X9+V+tNIVEJ4Mxa1hUjJ3KPaHnEZNtLBg zuul-build-sshkey 2025-03-02 00:16:50.642337 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-02 00:16:50.642358 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-02 00:16:50.642375 | ubuntu-noble -> localhost | | .EX==.| 2025-03-02 00:16:50.642391 | ubuntu-noble -> localhost | | o++X++| 2025-03-02 00:16:50.642407 | ubuntu-noble -> localhost | | ..o+.* | 2025-03-02 00:16:50.642423 | ubuntu-noble -> localhost | | .+.=. | 2025-03-02 00:16:50.642439 | ubuntu-noble -> localhost | | S o .o.o.| 2025-03-02 00:16:50.642454 | ubuntu-noble -> localhost | | * * o...| 2025-03-02 00:16:50.642470 | ubuntu-noble -> localhost | | = O o + o| 2025-03-02 00:16:50.642486 | ubuntu-noble -> localhost | | * . +o| 2025-03-02 00:16:50.642502 | ubuntu-noble -> localhost | | ..*| 2025-03-02 00:16:50.642518 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-02 00:16:50.642563 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.229894 2025-03-02 00:16:50.649767 | 2025-03-02 00:16:50.649844 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-02 00:16:50.669154 | ubuntu-noble | ok 2025-03-02 00:16:50.678329 | ubuntu-noble | included: /var/lib/zuul/builds/1a319ee5dfa843a2889da0c8218d52e3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-02 00:16:50.686200 | 2025-03-02 00:16:50.686268 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-02 00:16:50.710411 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:50.716503 | 2025-03-02 00:16:50.716576 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-02 00:16:51.447850 | ubuntu-noble | changed 2025-03-02 00:16:51.453348 | 2025-03-02 00:16:51.453416 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-02 00:16:51.821808 | ubuntu-noble | ok 2025-03-02 00:16:51.828958 | 2025-03-02 00:16:51.829067 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-02 00:16:52.596899 | ubuntu-noble | changed 2025-03-02 00:16:52.603880 | 2025-03-02 00:16:52.603959 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-02 00:16:53.368529 | ubuntu-noble | changed 2025-03-02 00:16:53.375382 | 2025-03-02 00:16:53.375471 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-02 00:16:53.399812 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:53.406924 | 2025-03-02 00:16:53.407011 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-02 00:16:53.844057 | ubuntu-noble -> localhost | changed 2025-03-02 00:16:53.857187 | 2025-03-02 00:16:53.857278 | TASK [add-build-sshkey : Add back temp key] 2025-03-02 00:16:54.237678 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1a319ee5dfa843a2889da0c8218d52e3/work/1a319ee5dfa843a2889da0c8218d52e3_id_rsa (zuul-build-sshkey) 2025-03-02 00:16:54.237923 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007995 2025-03-02 00:16:54.274819 | 2025-03-02 00:16:54.274918 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-02 00:16:54.709051 | ubuntu-noble | ok 2025-03-02 00:16:54.721502 | 2025-03-02 00:16:54.721610 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-02 00:16:54.776083 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 00:16:54.793135 | 2025-03-02 00:16:54.793235 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-02 00:16:55.221627 | ubuntu-noble | ok 2025-03-02 00:16:55.242947 | 2025-03-02 00:16:55.243055 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-02 00:16:55.274148 | ubuntu-noble | ok 2025-03-02 00:16:55.282901 | 2025-03-02 00:16:55.282991 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-02 00:16:55.570278 | ubuntu-noble -> localhost | ok 2025-03-02 00:16:55.577876 | 2025-03-02 00:16:55.577963 | TASK [validate-host : Collect information about the host] 2025-03-02 00:16:56.813085 | ubuntu-noble | ok 2025-03-02 00:16:56.822607 | 2025-03-02 00:16:56.822707 | TASK [validate-host : Sanitize hostname] 2025-03-02 00:16:56.911356 | ubuntu-noble | ok 2025-03-02 00:16:56.917990 | 2025-03-02 00:16:56.918070 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-02 00:16:57.501713 | ubuntu-noble -> localhost | changed 2025-03-02 00:16:57.507210 | 2025-03-02 00:16:57.507288 | TASK [validate-host : Collect information about zuul worker] 2025-03-02 00:16:57.960347 | ubuntu-noble | ok 2025-03-02 00:16:57.965505 | 2025-03-02 00:16:57.965581 | TASK [validate-host : Write out all zuul information for each host] 2025-03-02 00:16:58.623743 | ubuntu-noble -> localhost | changed 2025-03-02 00:16:58.634340 | 2025-03-02 00:16:58.634422 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-02 00:16:58.972738 | ubuntu-noble | ok 2025-03-02 00:16:58.979414 | 2025-03-02 00:16:58.979503 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-02 00:17:00.047280 | ubuntu-noble | changed: 2025-03-02 00:17:00.047442 | ubuntu-noble | cd+++++++++ src/ 2025-03-02 00:17:00.047473 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-02 00:17:00.047500 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-02 00:17:00.047521 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-03-02 00:17:00.047541 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-02 00:18:11.479044 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-02 00:18:11.510532 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-02 00:18:11.539646 | ubuntu-noble | Downloading types_requests-2.32.0.20250301-py3-none-any.whl (20 kB) 2025-03-02 00:18:11.569504 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-03-02 00:18:11.600416 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-02 00:18:11.991146 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-03-02 00:18:12.184029 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.2.0.20250224 types-requests-2.32.0.20250301 types-simplejson-3.20.0.20250218 types-tabulate-0.9.0.20241207 2025-03-02 00:18:20.806145 | ubuntu-noble | Installing missing stub packages: 2025-03-02 00:18:20.831606 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-03-02 00:18:20.831683 | ubuntu-noble | 2025-03-02 00:18:20.831691 | ubuntu-noble | 2025-03-02 00:18:20.831706 | ubuntu-noble | Success: no issues found in 11 source files 2025-03-02 00:18:20.983063 | ubuntu-noble | ok 2025-03-02 00:18:21.027061 | 2025-03-02 00:18:21.027255 | PLAY RECAP 2025-03-02 00:18:21.027321 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-02 00:18:21.027358 | 2025-03-02 00:18:21.203052 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-02 00:18:21.205750 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 00:18:21.905003 | 2025-03-02 00:18:21.905171 | PLAY [Base post] 2025-03-02 00:18:21.931254 | 2025-03-02 00:18:21.931392 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-02 00:18:22.642081 | ubuntu-noble | changed 2025-03-02 00:18:22.676060 | 2025-03-02 00:18:22.676188 | PLAY RECAP 2025-03-02 00:18:22.676254 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-02 00:18:22.676319 | 2025-03-02 00:18:22.825628 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 00:18:22.831325 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-02 00:18:23.585883 | 2025-03-02 00:18:23.586052 | PLAY [Base post-logs] 2025-03-02 00:18:23.602336 | 2025-03-02 00:18:23.602467 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-02 00:18:24.064567 | localhost | changed 2025-03-02 00:18:24.071413 | 2025-03-02 00:18:24.071603 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-02 00:18:24.115927 | localhost | ok 2025-03-02 00:18:24.127746 | 2025-03-02 00:18:24.127903 | TASK [Set zuul-log-path fact] 2025-03-02 00:18:24.148031 | localhost | ok 2025-03-02 00:18:24.165026 | 2025-03-02 00:18:24.165143 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 00:18:24.217717 | localhost | ok 2025-03-02 00:18:24.224087 | 2025-03-02 00:18:24.224257 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 00:18:24.260365 | localhost | skipping: Conditional result was False 2025-03-02 00:18:24.267942 | 2025-03-02 00:18:24.268151 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 00:18:24.309141 | localhost | skipping: Conditional result was False 2025-03-02 00:18:24.315398 | 2025-03-02 00:18:24.315566 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 00:18:24.341740 | localhost | skipping: Conditional result was False 2025-03-02 00:18:24.349161 | 2025-03-02 00:18:24.349354 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 00:18:24.377304 | localhost | skipping: Conditional result was False 2025-03-02 00:18:24.384527 | 2025-03-02 00:18:24.384736 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 00:18:24.410936 | localhost | skipping: Conditional result was False 2025-03-02 00:18:24.423753 | 2025-03-02 00:18:24.423903 | TASK [upload-logs : Create log directories] 2025-03-02 00:18:24.963647 | localhost | changed 2025-03-02 00:18:24.968160 | 2025-03-02 00:18:24.968263 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-02 00:18:25.482543 | localhost -> localhost | ok: Runtime: 0:00:00.009047 2025-03-02 00:18:25.488126 | 2025-03-02 00:18:25.488237 | TASK [upload-logs : Upload logs to log server] 2025-03-02 00:18:26.088581 | localhost | Output suppressed because no_log was given 2025-03-02 00:18:26.091971 | 2025-03-02 00:18:26.092081 | LOOP [upload-logs : Compress console log and json output] 2025-03-02 00:18:26.165299 | localhost | skipping: Conditional result was False 2025-03-02 00:18:26.182373 | localhost | skipping: Conditional result was False 2025-03-02 00:18:26.197184 | 2025-03-02 00:18:26.197369 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-02 00:18:26.261879 | localhost | skipping: Conditional result was False 2025-03-02 00:18:26.262510 | 2025-03-02 00:18:26.273225 | localhost | skipping: Conditional result was False 2025-03-02 00:18:26.287332 | 2025-03-02 00:18:26.287445 | LOOP [upload-logs : Upload console log and json output]