2025-03-22 14:57:36.663804 | Job console starting... 2025-03-22 14:57:36.685705 | Updating repositories 2025-03-22 14:57:36.762436 | Preparing job workspace 2025-03-22 14:57:38.580863 | Running Ansible setup... 2025-03-22 14:57:44.548840 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-22 14:57:45.453482 | 2025-03-22 14:57:45.453684 | PLAY [Base pre] 2025-03-22 14:57:45.482918 | 2025-03-22 14:57:45.483054 | TASK [Setup log path fact] 2025-03-22 14:57:45.514607 | ubuntu-noble | ok 2025-03-22 14:57:45.556040 | 2025-03-22 14:57:45.556190 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-22 14:57:45.659019 | ubuntu-noble | ok 2025-03-22 14:57:45.668662 | 2025-03-22 14:57:45.668791 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-22 14:57:45.704409 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:45.711945 | 2025-03-22 14:57:45.712079 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-22 14:57:45.800116 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:45.807933 | 2025-03-22 14:57:45.808055 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-22 14:57:45.856234 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:45.863701 | 2025-03-22 14:57:45.863816 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-22 14:57:45.913987 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:45.926720 | 2025-03-22 14:57:45.927007 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-22 14:57:45.983996 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:46.024097 | 2025-03-22 14:57:46.024229 | TASK [emit-job-header : Print job information] 2025-03-22 14:57:46.139064 | # Job Information 2025-03-22 14:57:46.139260 | Ansible Version: 2.15.3 2025-03-22 14:57:46.139292 | Job: mypy 2025-03-22 14:57:46.139321 | Pipeline: check 2025-03-22 14:57:46.139342 | Executor: 7d211f194f6a 2025-03-22 14:57:46.139361 | Triggered by: https://github.com/osism/python-osism/pull/1239 2025-03-22 14:57:46.139380 | Event ID: f84e2900-072d-11f0-88bf-694ce0b4971d 2025-03-22 14:57:46.145896 | 2025-03-22 14:57:46.146004 | LOOP [emit-job-header : Print node information] 2025-03-22 14:57:46.350323 | ubuntu-noble | ok: 2025-03-22 14:57:46.350519 | ubuntu-noble | # Node Information 2025-03-22 14:57:46.350594 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-22 14:57:46.350620 | ubuntu-noble | Hostname: ubuntu 2025-03-22 14:57:46.350642 | ubuntu-noble | Username: zuul 2025-03-22 14:57:46.350662 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-22 14:57:46.350681 | ubuntu-noble | Provider: regiocloud-a 2025-03-22 14:57:46.350702 | ubuntu-noble | Label: ubuntu-noble 2025-03-22 14:57:46.350721 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-22 14:57:46.350741 | ubuntu-noble | Interface IP: 81.163.193.99 2025-03-22 14:57:46.393803 | 2025-03-22 14:57:46.393986 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-22 14:57:47.146046 | ubuntu-noble -> localhost | changed 2025-03-22 14:57:47.163155 | 2025-03-22 14:57:47.163273 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-22 14:57:48.308995 | ubuntu-noble -> localhost | changed 2025-03-22 14:57:48.329395 | 2025-03-22 14:57:48.329486 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-22 14:57:48.630028 | ubuntu-noble -> localhost | ok 2025-03-22 14:57:48.635761 | 2025-03-22 14:57:48.635839 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-22 14:57:48.674337 | ubuntu-noble | ok 2025-03-22 14:57:48.687668 | ubuntu-noble | included: /var/lib/zuul/builds/52a38bf0430f4ab798b2e0b03c483bbb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-22 14:57:48.693887 | 2025-03-22 14:57:48.693956 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-22 14:57:49.421358 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-22 14:57:49.421646 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/52a38bf0430f4ab798b2e0b03c483bbb/work/52a38bf0430f4ab798b2e0b03c483bbb_id_rsa 2025-03-22 14:57:49.421687 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/52a38bf0430f4ab798b2e0b03c483bbb/work/52a38bf0430f4ab798b2e0b03c483bbb_id_rsa.pub 2025-03-22 14:57:49.421713 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-22 14:57:49.421735 | ubuntu-noble -> localhost | SHA256:5Az35KclYKokz5G/ks3WKSUgyd7JQrZUVGUhKWEd+hk zuul-build-sshkey 2025-03-22 14:57:49.421756 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-22 14:57:49.421780 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-22 14:57:49.421802 | ubuntu-noble -> localhost | | .+++++. | 2025-03-22 14:57:49.421821 | ubuntu-noble -> localhost | | .o.oo | 2025-03-22 14:57:49.421840 | ubuntu-noble -> localhost | | . o..E = . | 2025-03-22 14:57:49.421859 | ubuntu-noble -> localhost | | B .o @ = | 2025-03-22 14:57:49.421877 | ubuntu-noble -> localhost | | =.=+o+ S + o | 2025-03-22 14:57:49.421896 | ubuntu-noble -> localhost | | +=++. . = | 2025-03-22 14:57:49.421914 | ubuntu-noble -> localhost | | .++.+ .. | 2025-03-22 14:57:49.421934 | ubuntu-noble -> localhost | | o =.o | 2025-03-22 14:57:49.421952 | ubuntu-noble -> localhost | | o.. | 2025-03-22 14:57:49.421971 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-22 14:57:49.422020 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.195339 2025-03-22 14:57:49.430603 | 2025-03-22 14:57:49.430696 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-22 14:57:49.460648 | ubuntu-noble | ok 2025-03-22 14:57:49.475251 | ubuntu-noble | included: /var/lib/zuul/builds/52a38bf0430f4ab798b2e0b03c483bbb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-22 14:57:49.488364 | 2025-03-22 14:57:49.488472 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-22 14:57:49.502641 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:49.509761 | 2025-03-22 14:57:49.509850 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-22 14:57:50.340354 | ubuntu-noble | changed 2025-03-22 14:57:50.360787 | 2025-03-22 14:57:50.360870 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-22 14:57:50.725905 | ubuntu-noble | ok 2025-03-22 14:57:50.739128 | 2025-03-22 14:57:50.739252 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-22 14:57:51.533843 | ubuntu-noble | changed 2025-03-22 14:57:51.544828 | 2025-03-22 14:57:51.544950 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-22 14:57:52.350598 | ubuntu-noble | changed 2025-03-22 14:57:52.359896 | 2025-03-22 14:57:52.359995 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-22 14:57:52.384680 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:52.393652 | 2025-03-22 14:57:52.393743 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-22 14:57:52.865218 | ubuntu-noble -> localhost | changed 2025-03-22 14:57:52.878493 | 2025-03-22 14:57:52.878591 | TASK [add-build-sshkey : Add back temp key] 2025-03-22 14:57:53.313057 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/52a38bf0430f4ab798b2e0b03c483bbb/work/52a38bf0430f4ab798b2e0b03c483bbb_id_rsa (zuul-build-sshkey) 2025-03-22 14:57:53.313247 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010507 2025-03-22 14:57:53.343912 | 2025-03-22 14:57:53.344106 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-22 14:57:53.727256 | ubuntu-noble | ok 2025-03-22 14:57:53.743161 | 2025-03-22 14:57:53.743396 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-22 14:57:53.777808 | ubuntu-noble | skipping: Conditional result was False 2025-03-22 14:57:53.788978 | 2025-03-22 14:57:53.789065 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-22 14:57:54.276378 | ubuntu-noble | ok 2025-03-22 14:57:54.291883 | 2025-03-22 14:57:54.291983 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-22 14:57:54.331735 | ubuntu-noble | ok 2025-03-22 14:57:54.338589 | 2025-03-22 14:57:54.338672 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-22 14:57:54.606687 | ubuntu-noble -> localhost | ok 2025-03-22 14:57:54.615303 | 2025-03-22 14:57:54.615391 | TASK [validate-host : Collect information about the host] 2025-03-22 14:57:55.871947 | ubuntu-noble | ok 2025-03-22 14:57:55.889832 | 2025-03-22 14:57:55.889927 | TASK [validate-host : Sanitize hostname] 2025-03-22 14:57:55.951276 | ubuntu-noble | ok 2025-03-22 14:57:55.958030 | 2025-03-22 14:57:55.958239 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-22 14:57:56.442808 | ubuntu-noble -> localhost | changed 2025-03-22 14:57:56.448495 | 2025-03-22 14:57:56.448586 | TASK [validate-host : Collect information about zuul worker] 2025-03-22 14:57:56.909133 | ubuntu-noble | ok 2025-03-22 14:57:56.924975 | 2025-03-22 14:57:56.925071 | TASK [validate-host : Write out all zuul information for each host] 2025-03-22 14:57:57.588562 | ubuntu-noble -> localhost | changed 2025-03-22 14:57:57.603327 | 2025-03-22 14:57:57.603415 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-22 14:57:57.950089 | ubuntu-noble | ok 2025-03-22 14:57:57.956892 | 2025-03-22 14:57:57.956978 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-22 14:57:59.187915 | ubuntu-noble | changed: 2025-03-22 14:57:59.188229 | ubuntu-noble | cd+++++++++ src/ 2025-03-22 14:57:59.188273 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-22 14:57:59.188476 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-22 14:57:59.188506 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-22 14:57:59.188528 | ubuntu-noble | Containerfile 2025-03-22 14:57:59.189736 | ubuntu-noble | =35.0.0 in /tmp/venv/lib/python3.12/site-packages (from types-pyOpenSSL) (44.0.2) 2025-03-22 15:00:11.685919 | ubuntu-noble | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-22 15:00:11.721608 | 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-22 15:00:11.817656 | ubuntu-noble | Collecting types-setuptools (from types-cffi->types-pyOpenSSL) 2025-03-22 15:00:11.832722 | ubuntu-noble | Downloading types_setuptools-76.0.0.20250313-py3-none-any.whl.metadata (2.2 kB) 2025-03-22 15:00:11.850759 | 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-22 15:00:11.858627 | ubuntu-noble | Requirement already satisfied: setuptools in /tmp/venv/lib/python3.12/site-packages (from types-setuptools->types-cffi->types-pyOpenSSL) (76.0.0) 2025-03-22 15:00:11.931406 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-22 15:00:11.957507 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-22 15:00:11.985168 | ubuntu-noble | Downloading types_pyOpenSSL-24.1.0.20240722-py3-none-any.whl (7.5 kB) 2025-03-22 15:00:12.012942 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-03-22 15:00:12.037228 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250318-py3-none-any.whl (10 kB) 2025-03-22 15:00:12.069901 | ubuntu-noble | Downloading types_requests-2.32.0.20250306-py3-none-any.whl (20 kB) 2025-03-22 15:00:12.099914 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250318-py3-none-any.whl (10 kB) 2025-03-22 15:00:12.127186 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-22 15:00:12.161128 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-03-22 15:00:12.187062 | ubuntu-noble | Downloading types_cffi-1.17.0.20250319-py3-none-any.whl (19 kB) 2025-03-22 15:00:12.210365 | ubuntu-noble | Downloading types_setuptools-76.0.0.20250313-py3-none-any.whl (65 kB) 2025-03-22 15:00:12.234186 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.8/65.8 kB 3.0 MB/s eta 0:00:00 2025-03-22 15:00:13.153681 | 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-22 15:00:13.681559 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-cffi-1.17.0.20250319 types-decorator-5.2.0.20250224 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20241206 types-pytz-2025.1.0.20250318 types-requests-2.32.0.20250306 types-setuptools-76.0.0.20250313 types-simplejson-3.20.0.20250318 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-03-22 15:00:30.968824 | 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-22 15:00:31.002613 | 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-22 15:00:31.002696 | ubuntu-noble | Installing missing stub packages: 2025-03-22 15:00:31.002706 | 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-22 15:00:31.002724 | ubuntu-noble | 2025-03-22 15:00:31.002730 | ubuntu-noble | 2025-03-22 15:00:31.002735 | ubuntu-noble | Success: no issues found in 50 source files 2025-03-22 15:00:31.179391 | ubuntu-noble | ok 2025-03-22 15:00:31.220227 | 2025-03-22 15:00:31.220317 | PLAY RECAP 2025-03-22 15:00:31.220376 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-22 15:00:31.220564 | 2025-03-22 15:00:31.341799 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-22 15:00:31.344322 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-22 15:00:32.081381 | 2025-03-22 15:00:32.081521 | PLAY [Base post] 2025-03-22 15:00:32.106605 | 2025-03-22 15:00:32.106728 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-22 15:00:32.829903 | ubuntu-noble | changed 2025-03-22 15:00:32.868225 | 2025-03-22 15:00:32.868338 | PLAY RECAP 2025-03-22 15:00:32.868461 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-22 15:00:32.868526 | 2025-03-22 15:00:32.974318 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-22 15:00:32.981056 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-22 15:00:33.704065 | 2025-03-22 15:00:33.704226 | PLAY [Base post-logs] 2025-03-22 15:00:33.722714 | 2025-03-22 15:00:33.722850 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-22 15:00:34.208377 | localhost | changed 2025-03-22 15:00:34.216150 | 2025-03-22 15:00:34.216335 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-22 15:00:34.250717 | localhost | ok 2025-03-22 15:00:34.260920 | 2025-03-22 15:00:34.261047 | TASK [Set zuul-log-path fact] 2025-03-22 15:00:34.290433 | localhost | ok 2025-03-22 15:00:34.306747 | 2025-03-22 15:00:34.306987 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-22 15:00:34.356180 | localhost | ok 2025-03-22 15:00:34.361685 | 2025-03-22 15:00:34.361832 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-22 15:00:34.397469 | localhost | skipping: Conditional result was False 2025-03-22 15:00:34.406935 | 2025-03-22 15:00:34.407149 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-22 15:00:34.448463 | localhost | skipping: Conditional result was False 2025-03-22 15:00:34.457755 | 2025-03-22 15:00:34.457974 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-22 15:00:34.475418 | localhost | skipping: Conditional result was False 2025-03-22 15:00:34.481471 | 2025-03-22 15:00:34.481678 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-22 15:00:34.507747 | localhost | skipping: Conditional result was False 2025-03-22 15:00:34.517034 | 2025-03-22 15:00:34.517247 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-22 15:00:34.535116 | localhost | skipping: Conditional result was False 2025-03-22 15:00:34.544355 | 2025-03-22 15:00:34.544515 | TASK [upload-logs : Create log directories] 2025-03-22 15:00:35.063999 | localhost | changed 2025-03-22 15:00:35.077534 | 2025-03-22 15:00:35.077705 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-22 15:00:35.572728 | localhost -> localhost | ok: Runtime: 0:00:00.007306 2025-03-22 15:00:35.578387 | 2025-03-22 15:00:35.578499 | TASK [upload-logs : Upload logs to log server] 2025-03-22 15:00:36.144521 | localhost | Output suppressed because no_log was given 2025-03-22 15:00:36.150231 | 2025-03-22 15:00:36.150387 | LOOP [upload-logs : Compress console log and json output] 2025-03-22 15:00:36.221445 | localhost | skipping: Conditional result was False 2025-03-22 15:00:36.238702 | localhost | skipping: Conditional result was False 2025-03-22 15:00:36.256416 | 2025-03-22 15:00:36.256617 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-22 15:00:36.318248 | localhost | skipping: Conditional result was False 2025-03-22 15:00:36.318930 | 2025-03-22 15:00:36.331003 | localhost | skipping: Conditional result was False 2025-03-22 15:00:36.342401 | 2025-03-22 15:00:36.342605 | LOOP [upload-logs : Upload console log and json output]