2025-01-16 14:40:33.700890 | Job console starting... 2025-01-16 14:40:33.731643 | Updating repositories 2025-01-16 14:40:33.792641 | Preparing job workspace 2025-01-16 14:40:36.196462 | Running Ansible setup... 2025-01-16 14:40:42.520073 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-16 14:40:43.577413 | 2025-01-16 14:40:43.577542 | PLAY [Base pre] 2025-01-16 14:40:43.627850 | 2025-01-16 14:40:43.627984 | TASK [Setup log path fact] 2025-01-16 14:40:43.680426 | ubuntu-noble | ok 2025-01-16 14:40:43.721857 | 2025-01-16 14:40:43.721998 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 14:40:43.823463 | ubuntu-noble | ok 2025-01-16 14:40:43.830056 | 2025-01-16 14:40:43.830162 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 14:40:43.909021 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:43.915980 | 2025-01-16 14:40:43.916086 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 14:40:43.990850 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:43.998052 | 2025-01-16 14:40:43.998183 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 14:40:44.011623 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:44.018900 | 2025-01-16 14:40:44.019012 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 14:40:44.033376 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:44.041521 | 2025-01-16 14:40:44.041633 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 14:40:44.089125 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:44.103528 | 2025-01-16 14:40:44.103635 | TASK [emit-job-header : Print job information] 2025-01-16 14:40:44.179617 | # Job Information 2025-01-16 14:40:44.179831 | Ansible Version: 2.15.3 2025-01-16 14:40:44.179865 | Job: mypy 2025-01-16 14:40:44.179894 | Pipeline: check 2025-01-16 14:40:44.179916 | Executor: 7d211f194f6a 2025-01-16 14:40:44.179935 | Triggered by: https://github.com/osism/python-osism/pull/1177 2025-01-16 14:40:44.179953 | Event ID: d26e3930-d417-11ef-8f3c-78376428a64a 2025-01-16 14:40:44.186040 | 2025-01-16 14:40:44.186129 | LOOP [emit-job-header : Print node information] 2025-01-16 14:40:44.418397 | ubuntu-noble | ok: 2025-01-16 14:40:44.418605 | ubuntu-noble | # Node Information 2025-01-16 14:40:44.418642 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-16 14:40:44.418666 | ubuntu-noble | Hostname: ubuntu 2025-01-16 14:40:44.418686 | ubuntu-noble | Username: zuul 2025-01-16 14:40:44.418706 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-16 14:40:44.418725 | ubuntu-noble | Provider: regiocloud-a 2025-01-16 14:40:44.418744 | ubuntu-noble | Label: ubuntu-noble 2025-01-16 14:40:44.418763 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-16 14:40:44.418782 | ubuntu-noble | Interface IP: 81.163.193.18 2025-01-16 14:40:44.435425 | 2025-01-16 14:40:44.435535 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-16 14:40:45.331897 | ubuntu-noble -> localhost | changed 2025-01-16 14:40:45.339737 | 2025-01-16 14:40:45.339834 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-16 14:40:46.658301 | ubuntu-noble -> localhost | changed 2025-01-16 14:40:46.686215 | 2025-01-16 14:40:46.686336 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-16 14:40:47.005810 | ubuntu-noble -> localhost | ok 2025-01-16 14:40:47.012039 | 2025-01-16 14:40:47.012124 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-16 14:40:47.055738 | ubuntu-noble | ok 2025-01-16 14:40:47.099066 | ubuntu-noble | included: /var/lib/zuul/builds/9d39353dc55a4643b75d28c43c722cd1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-16 14:40:47.115219 | 2025-01-16 14:40:47.115310 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-16 14:40:48.245188 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-16 14:40:48.245762 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9d39353dc55a4643b75d28c43c722cd1/work/9d39353dc55a4643b75d28c43c722cd1_id_rsa 2025-01-16 14:40:48.249946 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9d39353dc55a4643b75d28c43c722cd1/work/9d39353dc55a4643b75d28c43c722cd1_id_rsa.pub 2025-01-16 14:40:48.250013 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-16 14:40:48.250038 | ubuntu-noble -> localhost | SHA256:PKVKLimx/trGE8BC5hRnxpx1VvZ8n8qnOJNx5Gdy3Q0 zuul-build-sshkey 2025-01-16 14:40:48.250059 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-16 14:40:48.250082 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-16 14:40:48.250100 | ubuntu-noble -> localhost | | .++o. o.o | 2025-01-16 14:40:48.250117 | ubuntu-noble -> localhost | | +++ o . o | 2025-01-16 14:40:48.250134 | ubuntu-noble -> localhost | |=. .o . | 2025-01-16 14:40:48.250158 | ubuntu-noble -> localhost | |..o . o ..E .| 2025-01-16 14:40:48.250175 | ubuntu-noble -> localhost | | ... . S o ++| 2025-01-16 14:40:48.250191 | ubuntu-noble -> localhost | | o.+ . . ..+.++| 2025-01-16 14:40:48.250207 | ubuntu-noble -> localhost | | o.o.o +o=. | 2025-01-16 14:40:48.250223 | ubuntu-noble -> localhost | | . o+. +. o | 2025-01-16 14:40:48.250239 | ubuntu-noble -> localhost | | o+o. .o. | 2025-01-16 14:40:48.250254 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-16 14:40:48.250306 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.514086 2025-01-16 14:40:48.256611 | 2025-01-16 14:40:48.256680 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-16 14:40:48.284926 | ubuntu-noble | ok 2025-01-16 14:40:48.293789 | ubuntu-noble | included: /var/lib/zuul/builds/9d39353dc55a4643b75d28c43c722cd1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-16 14:40:48.312094 | 2025-01-16 14:40:48.312202 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-16 14:40:48.326034 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:48.332543 | 2025-01-16 14:40:48.332626 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-16 14:40:49.129427 | ubuntu-noble | changed 2025-01-16 14:40:49.140044 | 2025-01-16 14:40:49.140136 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-16 14:40:49.444269 | ubuntu-noble | ok 2025-01-16 14:40:49.455071 | 2025-01-16 14:40:49.455202 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-16 14:40:50.172113 | ubuntu-noble | changed 2025-01-16 14:40:50.181238 | 2025-01-16 14:40:50.181334 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-16 14:40:50.870220 | ubuntu-noble | changed 2025-01-16 14:40:50.879058 | 2025-01-16 14:40:50.879166 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-16 14:40:50.903000 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:50.910110 | 2025-01-16 14:40:50.910230 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-16 14:40:51.320601 | ubuntu-noble -> localhost | changed 2025-01-16 14:40:51.337228 | 2025-01-16 14:40:51.337383 | TASK [add-build-sshkey : Add back temp key] 2025-01-16 14:40:51.755300 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9d39353dc55a4643b75d28c43c722cd1/work/9d39353dc55a4643b75d28c43c722cd1_id_rsa (zuul-build-sshkey) 2025-01-16 14:40:51.755439 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014522 2025-01-16 14:40:51.763064 | 2025-01-16 14:40:51.763176 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-16 14:40:52.223318 | ubuntu-noble | ok 2025-01-16 14:40:52.228829 | 2025-01-16 14:40:52.228912 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-16 14:40:52.263139 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 14:40:52.276381 | 2025-01-16 14:40:52.276482 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-16 14:40:52.814912 | ubuntu-noble | ok 2025-01-16 14:40:52.836691 | 2025-01-16 14:40:52.836824 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-16 14:40:52.866119 | ubuntu-noble | ok 2025-01-16 14:40:52.871372 | 2025-01-16 14:40:52.871450 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-16 14:40:53.201831 | ubuntu-noble -> localhost | ok 2025-01-16 14:40:53.208872 | 2025-01-16 14:40:53.208955 | TASK [validate-host : Collect information about the host] 2025-01-16 14:40:54.380904 | ubuntu-noble | ok 2025-01-16 14:40:54.392869 | 2025-01-16 14:40:54.392967 | TASK [validate-host : Sanitize hostname] 2025-01-16 14:40:54.452325 | ubuntu-noble | ok 2025-01-16 14:40:54.458510 | 2025-01-16 14:40:54.458602 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-16 14:40:55.098315 | ubuntu-noble -> localhost | changed 2025-01-16 14:40:55.106608 | 2025-01-16 14:40:55.106709 | TASK [validate-host : Collect information about zuul worker] 2025-01-16 14:40:55.633959 | ubuntu-noble | ok 2025-01-16 14:40:55.640193 | 2025-01-16 14:40:55.640294 | TASK [validate-host : Write out all zuul information for each host] 2025-01-16 14:40:56.309527 | ubuntu-noble -> localhost | changed 2025-01-16 14:40:56.325447 | 2025-01-16 14:40:56.325552 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-16 14:40:56.685404 | ubuntu-noble | ok 2025-01-16 14:40:56.698764 | 2025-01-16 14:40:56.698864 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-16 14:40:57.937144 | ubuntu-noble | changed: 2025-01-16 14:40:57.937295 | ubuntu-noble | cd+++++++++ src/ 2025-01-16 14:40:57.937322 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-16 14:40:57.937342 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-16 14:40:57.937359 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-01-16 14:40:57.937375 | ubuntu-noble | Containerfile 2025-01-16 14:40:57.937468 | ubuntu-noble | =35.0.0 in /tmp/venv/lib/python3.12/site-packages (from types-redis) (44.0.0) 2025-01-16 14:42:41.887750 | ubuntu-noble | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-16 14:42:41.918827 | ubuntu-noble | Requirement already satisfied: cffi>=1.12 in /tmp/venv/lib/python3.12/site-packages (from cryptography>=35.0.0->types-redis) (1.17.1) 2025-01-16 14:42:41.967661 | ubuntu-noble | Collecting types-cffi (from types-pyOpenSSL->types-redis) 2025-01-16 14:42:41.984479 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl.metadata (1.8 kB) 2025-01-16 14:42:41.997091 | ubuntu-noble | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.12/site-packages (from cffi>=1.12->cryptography>=35.0.0->types-redis) (2.22) 2025-01-16 14:42:42.062948 | ubuntu-noble | Collecting types-setuptools (from types-cffi->types-pyOpenSSL->types-redis) 2025-01-16 14:42:42.078244 | ubuntu-noble | Downloading types_setuptools-75.8.0.20250110-py3-none-any.whl.metadata (2.2 kB) 2025-01-16 14:42:42.107119 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-16 14:42:42.135080 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-16 14:42:42.161422 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-01-16 14:42:42.189184 | ubuntu-noble | Downloading types_pytz-2024.2.0.20241221-py3-none-any.whl (10 kB) 2025-01-16 14:42:42.219559 | ubuntu-noble | Downloading types_redis-4.6.0.20241004-py3-none-any.whl (58 kB) 2025-01-16 14:42:42.244685 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.7/58.7 kB 2.9 MB/s eta 0:00:00 2025-01-16 14:42:42.261200 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-16 14:42:42.287817 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-16 14:42:42.315702 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-16 14:42:42.345255 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-01-16 14:42:42.376673 | ubuntu-noble | Downloading types_pyOpenSSL-24.1.0.20240722-py3-none-any.whl (7.5 kB) 2025-01-16 14:42:42.405530 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl (19 kB) 2025-01-16 14:42:42.432116 | ubuntu-noble | Downloading types_setuptools-75.8.0.20250110-py3-none-any.whl (71 kB) 2025-01-16 14:42:42.448667 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.5/71.5 kB 5.9 MB/s eta 0:00:00 2025-01-16 14:42:43.214051 | 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, types-redis 2025-01-16 14:42:43.771817 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-cffi-1.16.0.20241221 types-decorator-5.1.8.20240310 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20241206 types-pytz-2024.2.0.20241221 types-redis-4.6.0.20241004 types-requests-2.32.0.20241016 types-setuptools-75.8.0.20250110 types-simplejson-3.19.0.20241221 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-01-16 14:42:52.775545 | ubuntu-noble | Installing missing stub packages: 2025-01-16 14:42:52.793427 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-python-dateutil types-pytz types-redis types-requests types-simplejson types-tabulate types-ujson 2025-01-16 14:42:52.793465 | ubuntu-noble | 2025-01-16 14:42:52.793470 | ubuntu-noble | 2025-01-16 14:42:52.793474 | ubuntu-noble | Success: no issues found in 55 source files 2025-01-16 14:42:53.143692 | ubuntu-noble | ok 2025-01-16 14:42:53.185895 | 2025-01-16 14:42:53.186237 | PLAY RECAP 2025-01-16 14:42:53.186347 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-16 14:42:53.186384 | 2025-01-16 14:42:53.335609 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-16 14:42:53.340772 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-16 14:42:54.079136 | 2025-01-16 14:42:54.079318 | PLAY [Base post] 2025-01-16 14:42:54.106813 | 2025-01-16 14:42:54.106955 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-16 14:42:54.697045 | ubuntu-noble | changed 2025-01-16 14:42:54.734826 | 2025-01-16 14:42:54.734982 | PLAY RECAP 2025-01-16 14:42:54.735057 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-16 14:42:54.735127 | 2025-01-16 14:42:54.861996 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-16 14:42:54.868866 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-16 14:42:55.641600 | 2025-01-16 14:42:55.641770 | PLAY [Base post-logs] 2025-01-16 14:42:55.658241 | 2025-01-16 14:42:55.658377 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-16 14:42:56.153717 | localhost | changed 2025-01-16 14:42:56.160672 | 2025-01-16 14:42:56.160866 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-16 14:42:56.194624 | localhost | ok 2025-01-16 14:42:56.205595 | 2025-01-16 14:42:56.205737 | TASK [Set zuul-log-path fact] 2025-01-16 14:42:56.239623 | localhost | ok 2025-01-16 14:42:56.257285 | 2025-01-16 14:42:56.257401 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 14:42:56.308922 | localhost | ok 2025-01-16 14:42:56.315179 | 2025-01-16 14:42:56.315404 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 14:42:56.361650 | localhost | skipping: Conditional result was False 2025-01-16 14:42:56.368736 | 2025-01-16 14:42:56.368887 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 14:42:56.417420 | localhost | skipping: Conditional result was False 2025-01-16 14:42:56.424826 | 2025-01-16 14:42:56.424983 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 14:42:56.451289 | localhost | skipping: Conditional result was False 2025-01-16 14:42:56.460172 | 2025-01-16 14:42:56.460377 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 14:42:56.486577 | localhost | skipping: Conditional result was False 2025-01-16 14:42:56.496276 | 2025-01-16 14:42:56.496457 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 14:42:56.522895 | localhost | skipping: Conditional result was False 2025-01-16 14:42:56.537560 | 2025-01-16 14:42:56.537714 | TASK [upload-logs : Create log directories] 2025-01-16 14:42:57.047773 | localhost | changed 2025-01-16 14:42:57.052291 | 2025-01-16 14:42:57.052393 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-16 14:42:57.570027 | localhost -> localhost | ok: Runtime: 0:00:00.006162 2025-01-16 14:42:57.575659 | 2025-01-16 14:42:57.575783 | TASK [upload-logs : Upload logs to log server] 2025-01-16 14:42:58.150241 | localhost | Output suppressed because no_log was given 2025-01-16 14:42:58.156869 | 2025-01-16 14:42:58.157028 | LOOP [upload-logs : Compress console log and json output] 2025-01-16 14:42:58.230651 | localhost | skipping: Conditional result was False 2025-01-16 14:42:58.248956 | localhost | skipping: Conditional result was False 2025-01-16 14:42:58.264588 | 2025-01-16 14:42:58.264824 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-16 14:42:58.339307 | localhost | skipping: Conditional result was False 2025-01-16 14:42:58.340687 | 2025-01-16 14:42:58.351093 | localhost | skipping: Conditional result was False 2025-01-16 14:42:58.366003 | 2025-01-16 14:42:58.366221 | LOOP [upload-logs : Upload console log and json output]