2025-03-01 22:58:50.950188 | Job console starting... 2025-03-01 22:58:50.979115 | Updating repositories 2025-03-01 22:58:51.022125 | Preparing job workspace 2025-03-01 22:58:53.252322 | Running Ansible setup... 2025-03-01 22:58:58.877713 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-01 22:58:59.762640 | 2025-03-01 22:58:59.762774 | PLAY [Base pre] 2025-03-01 22:58:59.804979 | 2025-03-01 22:58:59.805093 | TASK [Setup log path fact] 2025-03-01 22:58:59.846551 | ubuntu-noble | ok 2025-03-01 22:58:59.883667 | 2025-03-01 22:58:59.883779 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-01 22:58:59.925029 | ubuntu-noble | ok 2025-03-01 22:58:59.931534 | 2025-03-01 22:58:59.931620 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-01 22:58:59.975944 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:58:59.982675 | 2025-03-01 22:58:59.982770 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-01 22:59:00.037720 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:00.045320 | 2025-03-01 22:59:00.045433 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-01 22:59:00.080231 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:00.087555 | 2025-03-01 22:59:00.087649 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-01 22:59:00.132164 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:00.139354 | 2025-03-01 22:59:00.139447 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-01 22:59:00.184369 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:00.198859 | 2025-03-01 22:59:00.198960 | TASK [emit-job-header : Print job information] 2025-03-01 22:59:00.313416 | # Job Information 2025-03-01 22:59:00.313569 | Ansible Version: 2.15.3 2025-03-01 22:59:00.313602 | Job: mypy 2025-03-01 22:59:00.313631 | Pipeline: check 2025-03-01 22:59:00.313652 | Executor: 7d211f194f6a 2025-03-01 22:59:00.313671 | Triggered by: https://github.com/osism/python-osism/pull/1211 2025-03-01 22:59:00.313690 | Event ID: b832dde0-f6f0-11ef-93a4-b2724b8b5dcb 2025-03-01 22:59:00.324067 | 2025-03-01 22:59:00.324161 | LOOP [emit-job-header : Print node information] 2025-03-01 22:59:00.564900 | ubuntu-noble | ok: 2025-03-01 22:59:00.565069 | ubuntu-noble | # Node Information 2025-03-01 22:59:00.565103 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-01 22:59:00.565127 | ubuntu-noble | Hostname: ubuntu 2025-03-01 22:59:00.565149 | ubuntu-noble | Username: zuul 2025-03-01 22:59:00.565169 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-01 22:59:00.565189 | ubuntu-noble | Provider: regiocloud-a 2025-03-01 22:59:00.565209 | ubuntu-noble | Label: ubuntu-noble 2025-03-01 22:59:00.565229 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-01 22:59:00.565248 | ubuntu-noble | Interface IP: 81.163.193.194 2025-03-01 22:59:00.583031 | 2025-03-01 22:59:00.583161 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-01 22:59:01.232739 | ubuntu-noble -> localhost | changed 2025-03-01 22:59:01.240634 | 2025-03-01 22:59:01.240724 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-01 22:59:02.453682 | ubuntu-noble -> localhost | changed 2025-03-01 22:59:02.469490 | 2025-03-01 22:59:02.469592 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-01 22:59:02.793260 | ubuntu-noble -> localhost | ok 2025-03-01 22:59:02.800331 | 2025-03-01 22:59:02.800423 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-01 22:59:02.859025 | ubuntu-noble | ok 2025-03-01 22:59:02.876642 | ubuntu-noble | included: /var/lib/zuul/builds/0ba77dbc4065479ea4b0b79a6f15dadb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-01 22:59:02.883324 | 2025-03-01 22:59:02.883398 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-01 22:59:03.508872 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-01 22:59:03.509040 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ba77dbc4065479ea4b0b79a6f15dadb/work/0ba77dbc4065479ea4b0b79a6f15dadb_id_rsa 2025-03-01 22:59:03.509071 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ba77dbc4065479ea4b0b79a6f15dadb/work/0ba77dbc4065479ea4b0b79a6f15dadb_id_rsa.pub 2025-03-01 22:59:03.509092 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-01 22:59:03.509111 | ubuntu-noble -> localhost | SHA256:AFarllNxeFUV4PJCee6jWhQykmaQeEdksnBHQPAPLdI zuul-build-sshkey 2025-03-01 22:59:03.509129 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-01 22:59:03.509149 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-01 22:59:03.509167 | ubuntu-noble -> localhost | | o+OBO.....ooo. | 2025-03-01 22:59:03.509183 | ubuntu-noble -> localhost | | .*oOo=. o | 2025-03-01 22:59:03.509199 | ubuntu-noble -> localhost | | ..E.X.o = o | 2025-03-01 22:59:03.509215 | ubuntu-noble -> localhost | | . X o + * | 2025-03-01 22:59:03.509230 | ubuntu-noble -> localhost | | = . S o o | 2025-03-01 22:59:03.509245 | ubuntu-noble -> localhost | | . . . o | 2025-03-01 22:59:03.509261 | ubuntu-noble -> localhost | | . o | 2025-03-01 22:59:03.509277 | ubuntu-noble -> localhost | | . . . | 2025-03-01 22:59:03.509304 | ubuntu-noble -> localhost | | ... | 2025-03-01 22:59:03.509321 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-01 22:59:03.509362 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.092321 2025-03-01 22:59:03.515774 | 2025-03-01 22:59:03.515858 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-01 22:59:03.559517 | ubuntu-noble | ok 2025-03-01 22:59:03.573255 | ubuntu-noble | included: /var/lib/zuul/builds/0ba77dbc4065479ea4b0b79a6f15dadb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-01 22:59:03.588437 | 2025-03-01 22:59:03.588510 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-01 22:59:03.637031 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:03.650648 | 2025-03-01 22:59:03.650729 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-01 22:59:04.424523 | ubuntu-noble | changed 2025-03-01 22:59:04.430753 | 2025-03-01 22:59:04.430825 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-01 22:59:04.711557 | ubuntu-noble | ok 2025-03-01 22:59:04.719523 | 2025-03-01 22:59:04.719612 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-01 22:59:05.364072 | ubuntu-noble | changed 2025-03-01 22:59:05.374337 | 2025-03-01 22:59:05.374445 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-01 22:59:06.045007 | ubuntu-noble | changed 2025-03-01 22:59:06.053656 | 2025-03-01 22:59:06.053751 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-01 22:59:06.088007 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:06.096543 | 2025-03-01 22:59:06.096634 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-01 22:59:06.506454 | ubuntu-noble -> localhost | changed 2025-03-01 22:59:06.519680 | 2025-03-01 22:59:06.519777 | TASK [add-build-sshkey : Add back temp key] 2025-03-01 22:59:06.768869 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0ba77dbc4065479ea4b0b79a6f15dadb/work/0ba77dbc4065479ea4b0b79a6f15dadb_id_rsa (zuul-build-sshkey) 2025-03-01 22:59:06.769148 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007329 2025-03-01 22:59:06.779270 | 2025-03-01 22:59:06.779384 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-01 22:59:07.211605 | ubuntu-noble | ok 2025-03-01 22:59:07.216539 | 2025-03-01 22:59:07.216613 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-01 22:59:07.260303 | ubuntu-noble | skipping: Conditional result was False 2025-03-01 22:59:07.282806 | 2025-03-01 22:59:07.282902 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-01 22:59:07.658266 | ubuntu-noble | ok 2025-03-01 22:59:07.671677 | 2025-03-01 22:59:07.671774 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-01 22:59:07.718443 | ubuntu-noble | ok 2025-03-01 22:59:07.740770 | 2025-03-01 22:59:07.740881 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-01 22:59:08.008083 | ubuntu-noble -> localhost | ok 2025-03-01 22:59:08.015637 | 2025-03-01 22:59:08.015728 | TASK [validate-host : Collect information about the host] 2025-03-01 22:59:09.147776 | ubuntu-noble | ok 2025-03-01 22:59:09.160962 | 2025-03-01 22:59:09.161064 | TASK [validate-host : Sanitize hostname] 2025-03-01 22:59:09.221657 | ubuntu-noble | ok 2025-03-01 22:59:09.227460 | 2025-03-01 22:59:09.227547 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-01 22:59:09.728713 | ubuntu-noble -> localhost | changed 2025-03-01 22:59:09.735174 | 2025-03-01 22:59:09.735263 | TASK [validate-host : Collect information about zuul worker] 2025-03-01 22:59:10.180821 | ubuntu-noble | ok 2025-03-01 22:59:10.186688 | 2025-03-01 22:59:10.186780 | TASK [validate-host : Write out all zuul information for each host] 2025-03-01 22:59:10.643571 | ubuntu-noble -> localhost | changed 2025-03-01 22:59:10.656432 | 2025-03-01 22:59:10.656524 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-01 22:59:10.959633 | ubuntu-noble | ok 2025-03-01 22:59:10.978929 | 2025-03-01 22:59:10.979026 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-01 22:59:12.522299 | ubuntu-noble | changed: 2025-03-01 22:59:12.522498 | ubuntu-noble | cd+++++++++ src/ 2025-03-01 22:59:12.522530 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-01 22:59:12.522552 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-01 22:59:12.522573 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-01 22:59:12.522595 | ubuntu-noble | Containerfile 2025-03-01 22:59:12.522707 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-01 23:00:41.864903 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-01 23:00:41.887209 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-01 23:00:41.909306 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-03-01 23:00:41.933666 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250204-py3-none-any.whl (10 kB) 2025-03-01 23:00:41.957569 | ubuntu-noble | Downloading types_requests-2.32.0.20250301-py3-none-any.whl (20 kB) 2025-03-01 23:00:41.981201 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-03-01 23:00:42.005030 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-01 23:00:42.032869 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-03-01 23:00:42.687475 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator 2025-03-01 23:00:42.978670 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.2.0.20250224 types-python-dateutil-2.9.0.20241206 types-pytz-2025.1.0.20250204 types-requests-2.32.0.20250301 types-simplejson-3.20.0.20250218 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-03-01 23:00:50.160780 | ubuntu-noble | Installing missing stub packages: 2025-03-01 23:00:50.178939 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-03-01 23:00:50.178964 | ubuntu-noble | 2025-03-01 23:00:50.178969 | ubuntu-noble | 2025-03-01 23:00:50.178973 | ubuntu-noble | Success: no issues found in 55 source files 2025-03-01 23:00:50.551100 | ubuntu-noble | ok 2025-03-01 23:00:50.592922 | 2025-03-01 23:00:50.593026 | PLAY RECAP 2025-03-01 23:00:50.593089 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-01 23:00:50.593115 | 2025-03-01 23:00:50.719951 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-01 23:00:50.722889 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-01 23:00:51.428049 | 2025-03-01 23:00:51.428205 | PLAY [Base post] 2025-03-01 23:00:51.454410 | 2025-03-01 23:00:51.454544 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-01 23:00:52.032868 | ubuntu-noble | changed 2025-03-01 23:00:52.068917 | 2025-03-01 23:00:52.069044 | PLAY RECAP 2025-03-01 23:00:52.069112 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-01 23:00:52.069173 | 2025-03-01 23:00:52.180573 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-01 23:00:52.187261 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-01 23:00:52.997465 | 2025-03-01 23:00:52.997682 | PLAY [Base post-logs] 2025-03-01 23:00:53.016377 | 2025-03-01 23:00:53.016592 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-01 23:00:53.480983 | localhost | changed 2025-03-01 23:00:53.488827 | 2025-03-01 23:00:53.489015 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-01 23:00:53.534259 | localhost | ok 2025-03-01 23:00:53.546614 | 2025-03-01 23:00:53.546779 | TASK [Set zuul-log-path fact] 2025-03-01 23:00:53.579280 | localhost | ok 2025-03-01 23:00:53.599562 | 2025-03-01 23:00:53.599870 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-01 23:00:53.654282 | localhost | ok 2025-03-01 23:00:53.660854 | 2025-03-01 23:00:53.661024 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-01 23:00:53.708558 | localhost | skipping: Conditional result was False 2025-03-01 23:00:53.717328 | 2025-03-01 23:00:53.717532 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-01 23:00:53.768279 | localhost | skipping: Conditional result was False 2025-03-01 23:00:53.777583 | 2025-03-01 23:00:53.777818 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-01 23:00:53.806428 | localhost | skipping: Conditional result was False 2025-03-01 23:00:53.815610 | 2025-03-01 23:00:53.815844 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-01 23:00:53.843969 | localhost | skipping: Conditional result was False 2025-03-01 23:00:53.854711 | 2025-03-01 23:00:53.854943 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-01 23:00:53.882887 | localhost | skipping: Conditional result was False 2025-03-01 23:00:53.896523 | 2025-03-01 23:00:53.896683 | TASK [upload-logs : Create log directories] 2025-03-01 23:00:54.393661 | localhost | changed 2025-03-01 23:00:54.399569 | 2025-03-01 23:00:54.399701 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-01 23:00:54.894370 | localhost -> localhost | ok: Runtime: 0:00:00.007156 2025-03-01 23:00:54.901056 | 2025-03-01 23:00:54.901181 | TASK [upload-logs : Upload logs to log server] 2025-03-01 23:00:55.469545 | localhost | Output suppressed because no_log was given 2025-03-01 23:00:55.473599 | 2025-03-01 23:00:55.473983 | LOOP [upload-logs : Compress console log and json output] 2025-03-01 23:00:55.552986 | localhost | skipping: Conditional result was False 2025-03-01 23:00:55.583843 | localhost | skipping: Conditional result was False 2025-03-01 23:00:55.602805 | 2025-03-01 23:00:55.603051 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-01 23:00:55.679733 | localhost | skipping: Conditional result was False 2025-03-01 23:00:55.680450 | 2025-03-01 23:00:55.692746 | localhost | skipping: Conditional result was False 2025-03-01 23:00:55.713346 | 2025-03-01 23:00:55.713565 | LOOP [upload-logs : Upload console log and json output]