2025-03-31 12:54:36.917008 | Job console starting... 2025-03-31 12:54:36.927565 | Updating repositories 2025-03-31 12:54:37.384927 | Preparing job workspace 2025-03-31 12:54:40.292978 | Running Ansible setup... 2025-03-31 12:54:48.152742 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-31 12:54:49.538523 | 2025-03-31 12:54:49.538651 | PLAY [Base pre] 2025-03-31 12:54:49.590317 | 2025-03-31 12:54:49.590415 | TASK [Setup log path fact] 2025-03-31 12:54:49.635464 | ubuntu-noble | ok 2025-03-31 12:54:49.685581 | 2025-03-31 12:54:49.685686 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-31 12:54:49.742719 | ubuntu-noble | ok 2025-03-31 12:54:49.754008 | 2025-03-31 12:54:49.754085 | TASK [emit-job-header : Print job information] 2025-03-31 12:54:49.834723 | # Job Information 2025-03-31 12:54:49.834858 | Ansible Version: 2.15.3 2025-03-31 12:54:49.834885 | Job: mypy 2025-03-31 12:54:49.834924 | Pipeline: check 2025-03-31 12:54:49.834941 | Executor: 7d211f194f6a 2025-03-31 12:54:49.834956 | Triggered by: https://github.com/osism/python-osism/pull/1256 2025-03-31 12:54:49.834972 | Event ID: 47173380-0e2f-11f0-832d-f362f6a3989e 2025-03-31 12:54:49.840291 | 2025-03-31 12:54:49.840366 | LOOP [emit-job-header : Print node information] 2025-03-31 12:54:50.118442 | ubuntu-noble | ok: 2025-03-31 12:54:50.118674 | ubuntu-noble | # Node Information 2025-03-31 12:54:50.118731 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-31 12:54:50.118757 | ubuntu-noble | Hostname: ubuntu 2025-03-31 12:54:50.118778 | ubuntu-noble | Username: zuul 2025-03-31 12:54:50.118798 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-31 12:54:50.118821 | ubuntu-noble | Provider: regiocloud-a 2025-03-31 12:54:50.118841 | ubuntu-noble | Label: ubuntu-noble 2025-03-31 12:54:50.118860 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-31 12:54:50.118880 | ubuntu-noble | Interface IP: 81.163.193.97 2025-03-31 12:54:50.136321 | 2025-03-31 12:54:50.139840 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-31 12:54:51.014183 | ubuntu-noble -> localhost | changed 2025-03-31 12:54:51.022423 | 2025-03-31 12:54:51.022515 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-31 12:54:53.328056 | ubuntu-noble -> localhost | changed 2025-03-31 12:54:53.344068 | 2025-03-31 12:54:53.344182 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-31 12:54:54.003516 | ubuntu-noble -> localhost | ok 2025-03-31 12:54:54.013851 | 2025-03-31 12:54:54.013997 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-31 12:54:54.071797 | ubuntu-noble | ok 2025-03-31 12:54:54.127240 | ubuntu-noble | included: /var/lib/zuul/builds/46d6d8f3dd3540828d86bde83cd21b46/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-31 12:54:54.151379 | 2025-03-31 12:54:54.151468 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-31 12:54:55.208552 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-31 12:54:55.208717 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/46d6d8f3dd3540828d86bde83cd21b46/work/46d6d8f3dd3540828d86bde83cd21b46_id_rsa 2025-03-31 12:54:55.208746 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/46d6d8f3dd3540828d86bde83cd21b46/work/46d6d8f3dd3540828d86bde83cd21b46_id_rsa.pub 2025-03-31 12:54:55.208767 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-31 12:54:55.208787 | ubuntu-noble -> localhost | SHA256:Sm1/Z73VaMVWoFwm2f5S1YZ3BHcBCLxLW6ST7yhUou8 zuul-build-sshkey 2025-03-31 12:54:55.208805 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-31 12:54:55.208822 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-31 12:54:55.208838 | ubuntu-noble -> localhost | | ... o+*=*| 2025-03-31 12:54:55.208854 | ubuntu-noble -> localhost | | . +.=ooB| 2025-03-31 12:54:55.208870 | ubuntu-noble -> localhost | | = o. o+| 2025-03-31 12:54:55.208897 | ubuntu-noble -> localhost | | o B . ..o| 2025-03-31 12:54:55.208914 | ubuntu-noble -> localhost | | o S * o+| 2025-03-31 12:54:55.208930 | ubuntu-noble -> localhost | | o + + . .=o| 2025-03-31 12:54:55.208950 | ubuntu-noble -> localhost | | + + . =.+| 2025-03-31 12:54:55.208966 | ubuntu-noble -> localhost | | o . o + o| 2025-03-31 12:54:55.208982 | ubuntu-noble -> localhost | | .E. . | 2025-03-31 12:54:55.208998 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-31 12:54:55.209041 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.158137 2025-03-31 12:54:55.215478 | 2025-03-31 12:54:55.215564 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-31 12:54:55.266644 | ubuntu-noble | ok 2025-03-31 12:54:55.301933 | ubuntu-noble | included: /var/lib/zuul/builds/46d6d8f3dd3540828d86bde83cd21b46/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-31 12:54:55.314858 | 2025-03-31 12:54:55.314952 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-31 12:54:55.350760 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 12:54:55.356959 | 2025-03-31 12:54:55.357040 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-31 12:54:56.244896 | ubuntu-noble | changed 2025-03-31 12:54:56.250614 | 2025-03-31 12:54:56.250692 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-31 12:54:56.590375 | ubuntu-noble | ok 2025-03-31 12:54:56.596200 | 2025-03-31 12:54:56.596273 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-31 12:54:57.348058 | ubuntu-noble | changed 2025-03-31 12:54:57.358419 | 2025-03-31 12:54:57.358589 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-31 12:54:58.131899 | ubuntu-noble | changed 2025-03-31 12:54:58.138983 | 2025-03-31 12:54:58.139073 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-31 12:54:58.162945 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 12:54:58.170335 | 2025-03-31 12:54:58.170417 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-31 12:54:58.792999 | ubuntu-noble -> localhost | changed 2025-03-31 12:54:58.816082 | 2025-03-31 12:54:58.816319 | TASK [add-build-sshkey : Add back temp key] 2025-03-31 12:54:59.383047 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/46d6d8f3dd3540828d86bde83cd21b46/work/46d6d8f3dd3540828d86bde83cd21b46_id_rsa (zuul-build-sshkey) 2025-03-31 12:54:59.383268 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.019623 2025-03-31 12:54:59.397011 | 2025-03-31 12:54:59.397112 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-31 12:54:59.939279 | ubuntu-noble | ok 2025-03-31 12:54:59.945547 | 2025-03-31 12:54:59.945633 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-31 12:54:59.981060 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 12:54:59.993925 | 2025-03-31 12:54:59.994016 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-31 12:55:00.460544 | ubuntu-noble | ok 2025-03-31 12:55:00.492489 | 2025-03-31 12:55:00.492606 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-31 12:55:00.580145 | ubuntu-noble | ok 2025-03-31 12:55:00.601836 | 2025-03-31 12:55:00.601926 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-31 12:55:01.374893 | ubuntu-noble -> localhost | ok 2025-03-31 12:55:01.381254 | 2025-03-31 12:55:01.381331 | TASK [validate-host : Collect information about the host] 2025-03-31 12:55:02.605775 | ubuntu-noble | ok 2025-03-31 12:55:02.619560 | 2025-03-31 12:55:02.619651 | TASK [validate-host : Sanitize hostname] 2025-03-31 12:55:02.743156 | ubuntu-noble | ok 2025-03-31 12:55:02.748224 | 2025-03-31 12:55:02.748297 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-31 12:55:03.439870 | ubuntu-noble -> localhost | changed 2025-03-31 12:55:03.445605 | 2025-03-31 12:55:03.445693 | TASK [validate-host : Collect information about zuul worker] 2025-03-31 12:55:04.031278 | ubuntu-noble | ok 2025-03-31 12:55:04.036367 | 2025-03-31 12:55:04.036477 | TASK [validate-host : Write out all zuul information for each host] 2025-03-31 12:55:05.003402 | ubuntu-noble -> localhost | changed 2025-03-31 12:55:05.014158 | 2025-03-31 12:55:05.014262 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-31 12:55:05.342887 | ubuntu-noble | ok 2025-03-31 12:55:05.349366 | 2025-03-31 12:55:05.349456 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-31 12:55:06.367256 | ubuntu-noble | changed: 2025-03-31 12:55:06.367404 | ubuntu-noble | cd+++++++++ src/ 2025-03-31 12:55:06.367432 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-31 12:55:06.367452 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-31 12:55:06.367469 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-31 12:55:06.367486 | ubuntu-noble | Containerfile 2025-03-31 12:55:06.367577 | ubuntu-noble | =35.0.0 in /tmp/venv/lib/python3.12/site-packages (from types-pyOpenSSL) (44.0.2) 2025-03-31 12:56:55.736256 | ubuntu-noble | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-31 12:56:55.761338 | ubuntu-noble | Requirement already satisfied: cffi>=1.12 in /tmp/venv/lib/python3.12/site-packages (from cryptography>=35.0.0->types-pyOpenSSL) (1.17.1) 2025-03-31 12:56:55.838173 | ubuntu-noble | Collecting types-setuptools (from types-cffi->types-pyOpenSSL) 2025-03-31 12:56:55.850701 | ubuntu-noble | Downloading types_setuptools-78.1.0.20250329-py3-none-any.whl.metadata (2.2 kB) 2025-03-31 12:56:55.867860 | ubuntu-noble | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.12/site-packages (from cffi>=1.12->cryptography>=35.0.0->types-pyOpenSSL) (2.22) 2025-03-31 12:56:55.873727 | ubuntu-noble | Requirement already satisfied: setuptools in /tmp/venv/lib/python3.12/site-packages (from types-setuptools->types-cffi->types-pyOpenSSL) (78.1.0) 2025-03-31 12:56:55.934758 | ubuntu-noble | Downloading types_pyyaml-6.0.12.20250326-py3-none-any.whl (20 kB) 2025-03-31 12:56:55.962810 | ubuntu-noble | Downloading types_decorator-5.2.0.20250324-py3-none-any.whl (8.2 kB) 2025-03-31 12:56:55.988315 | ubuntu-noble | Downloading types_pyOpenSSL-24.1.0.20240722-py3-none-any.whl (7.5 kB) 2025-03-31 12:56:56.013413 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-03-31 12:56:56.037346 | ubuntu-noble | Downloading types_pytz-2025.2.0.20250326-py3-none-any.whl (10 kB) 2025-03-31 12:56:56.063044 | ubuntu-noble | Downloading types_requests-2.32.0.20250328-py3-none-any.whl (20 kB) 2025-03-31 12:56:56.088917 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250326-py3-none-any.whl (10 kB) 2025-03-31 12:56:56.114581 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-31 12:56:56.140022 | ubuntu-noble | Downloading types_ujson-5.10.0.20250326-py3-none-any.whl (7.6 kB) 2025-03-31 12:56:56.164971 | ubuntu-noble | Downloading types_cffi-1.17.0.20250326-py3-none-any.whl (20 kB) 2025-03-31 12:56:56.188658 | ubuntu-noble | Downloading types_setuptools-78.1.0.20250329-py3-none-any.whl (66 kB) 2025-03-31 12:56:56.211280 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 67.0/67.0 kB 3.7 MB/s eta 0:00:00 2025-03-31 12:56:56.976037 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-setuptools, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator, types-cffi, types-pyOpenSSL 2025-03-31 12:56:57.420213 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20250326 types-cffi-1.17.0.20250326 types-decorator-5.2.0.20250324 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20241206 types-pytz-2025.2.0.20250326 types-requests-2.32.0.20250328 types-setuptools-78.1.0.20250329 types-simplejson-3.20.0.20250326 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250326 2025-03-31 12:57:09.583108 | ubuntu-noble | osism/services/listener.py:186: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-03-31 12:57:09.603715 | ubuntu-noble | osism/services/listener.py:187: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-03-31 12:57:09.603757 | ubuntu-noble | Installing missing stub packages: 2025-03-31 12:57:09.603762 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-pyOpenSSL types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-03-31 12:57:09.603772 | ubuntu-noble | 2025-03-31 12:57:09.603777 | ubuntu-noble | 2025-03-31 12:57:09.603781 | ubuntu-noble | Success: no issues found in 50 source files 2025-03-31 12:57:09.847022 | ubuntu-noble | ok 2025-03-31 12:57:09.888489 | 2025-03-31 12:57:09.888596 | PLAY RECAP 2025-03-31 12:57:09.888663 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-31 12:57:09.888690 | 2025-03-31 12:57:10.028836 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-31 12:57:10.031570 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-31 12:57:10.756060 | 2025-03-31 12:57:10.756226 | PLAY [Base post] 2025-03-31 12:57:10.782633 | 2025-03-31 12:57:10.782763 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-31 12:57:11.422238 | ubuntu-noble | changed 2025-03-31 12:57:11.457282 | 2025-03-31 12:57:11.457433 | PLAY RECAP 2025-03-31 12:57:11.457498 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-31 12:57:11.457573 | 2025-03-31 12:57:11.591446 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-31 12:57:11.594530 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-31 12:57:12.370951 | 2025-03-31 12:57:12.371123 | PLAY [Base post-logs] 2025-03-31 12:57:12.387802 | 2025-03-31 12:57:12.387965 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-31 12:57:12.861907 | localhost | changed 2025-03-31 12:57:12.865933 | 2025-03-31 12:57:12.866071 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-31 12:57:12.905026 | localhost | ok 2025-03-31 12:57:12.911327 | 2025-03-31 12:57:12.911438 | TASK [Set zuul-log-path fact] 2025-03-31 12:57:12.930342 | localhost | ok 2025-03-31 12:57:12.941713 | 2025-03-31 12:57:12.941827 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-31 12:57:12.970542 | localhost | ok 2025-03-31 12:57:12.976546 | 2025-03-31 12:57:12.976658 | TASK [upload-logs : Create log directories] 2025-03-31 12:57:13.487765 | localhost | changed 2025-03-31 12:57:13.493193 | 2025-03-31 12:57:13.493315 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-31 12:57:13.994856 | localhost -> localhost | ok: Runtime: 0:00:00.008067 2025-03-31 12:57:14.005567 | 2025-03-31 12:57:14.005719 | TASK [upload-logs : Upload logs to log server] 2025-03-31 12:57:14.626293 | localhost | Output suppressed because no_log was given 2025-03-31 12:57:14.629742 | 2025-03-31 12:57:14.629857 | LOOP [upload-logs : Compress console log and json output] 2025-03-31 12:57:14.698722 | localhost | skipping: Conditional result was False 2025-03-31 12:57:14.716663 | localhost | skipping: Conditional result was False 2025-03-31 12:57:14.726496 | 2025-03-31 12:57:14.726653 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-31 12:57:14.812228 | localhost | skipping: Conditional result was False 2025-03-31 12:57:14.812596 | 2025-03-31 12:57:14.825763 | localhost | skipping: Conditional result was False 2025-03-31 12:57:14.836229 | 2025-03-31 12:57:14.836556 | LOOP [upload-logs : Upload console log and json output]