2025-01-21 09:26:57.082700 | Job console starting... 2025-01-21 09:26:57.113790 | Updating repositories 2025-01-21 09:26:57.198951 | Preparing job workspace 2025-01-21 09:26:59.443379 | Running Ansible setup... 2025-01-21 09:27:06.716599 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-21 09:27:07.743088 | 2025-01-21 09:27:07.743300 | PLAY [Base pre] 2025-01-21 09:27:07.774322 | 2025-01-21 09:27:07.774502 | TASK [Setup log path fact] 2025-01-21 09:27:07.817542 | ubuntu-noble | ok 2025-01-21 09:27:07.859537 | 2025-01-21 09:27:07.871362 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 09:27:07.965553 | ubuntu-noble | ok 2025-01-21 09:27:07.972544 | 2025-01-21 09:27:07.972685 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 09:27:08.060489 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:08.068489 | 2025-01-21 09:27:08.068639 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 09:27:08.124019 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:08.131966 | 2025-01-21 09:27:08.132107 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 09:27:08.177591 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:08.185527 | 2025-01-21 09:27:08.185795 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 09:27:08.247180 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:08.257200 | 2025-01-21 09:27:08.257365 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 09:27:08.312717 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:08.339724 | 2025-01-21 09:27:08.339876 | TASK [emit-job-header : Print job information] 2025-01-21 09:27:08.434931 | # Job Information 2025-01-21 09:27:08.435138 | Ansible Version: 2.15.3 2025-01-21 09:27:08.435171 | Job: mypy 2025-01-21 09:27:08.435200 | Pipeline: check 2025-01-21 09:27:08.435235 | Executor: 7d211f194f6a 2025-01-21 09:27:08.435255 | Triggered by: https://github.com/osism/python-osism/pull/1182 2025-01-21 09:27:08.435273 | Event ID: d6341fb0-d7d9-11ef-9def-74c35b9b6b72 2025-01-21 09:27:08.449078 | 2025-01-21 09:27:08.449263 | LOOP [emit-job-header : Print node information] 2025-01-21 09:27:08.644729 | ubuntu-noble | ok: 2025-01-21 09:27:08.645025 | ubuntu-noble | # Node Information 2025-01-21 09:27:08.645064 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-21 09:27:08.645088 | ubuntu-noble | Hostname: ubuntu 2025-01-21 09:27:08.645109 | ubuntu-noble | Username: zuul 2025-01-21 09:27:08.645130 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-21 09:27:08.645149 | ubuntu-noble | Provider: regiocloud-a 2025-01-21 09:27:08.645168 | ubuntu-noble | Label: ubuntu-noble 2025-01-21 09:27:08.645187 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-21 09:27:08.645249 | ubuntu-noble | Interface IP: 81.163.192.60 2025-01-21 09:27:08.672328 | 2025-01-21 09:27:08.672482 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-21 09:27:09.368320 | ubuntu-noble -> localhost | changed 2025-01-21 09:27:09.376681 | 2025-01-21 09:27:09.376785 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-21 09:27:10.900650 | ubuntu-noble -> localhost | changed 2025-01-21 09:27:10.922811 | 2025-01-21 09:27:10.922914 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-21 09:27:11.347107 | ubuntu-noble -> localhost | ok 2025-01-21 09:27:11.357086 | 2025-01-21 09:27:11.357184 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-21 09:27:11.385510 | ubuntu-noble | ok 2025-01-21 09:27:11.402663 | ubuntu-noble | included: /var/lib/zuul/builds/499dc3fbc0a34a7289def8e76b38317a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-21 09:27:11.408931 | 2025-01-21 09:27:11.409007 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-21 09:27:12.021189 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-21 09:27:12.021374 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/499dc3fbc0a34a7289def8e76b38317a/work/499dc3fbc0a34a7289def8e76b38317a_id_rsa 2025-01-21 09:27:12.021405 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/499dc3fbc0a34a7289def8e76b38317a/work/499dc3fbc0a34a7289def8e76b38317a_id_rsa.pub 2025-01-21 09:27:12.021426 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-21 09:27:12.021445 | ubuntu-noble -> localhost | SHA256:p1mt25SqyzTOZMC5ZvZtoqtFBr1LCoJN3EzCAERSYn4 zuul-build-sshkey 2025-01-21 09:27:12.021463 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-21 09:27:12.021483 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-21 09:27:12.021501 | ubuntu-noble -> localhost | |OBo . | 2025-01-21 09:27:12.021517 | ubuntu-noble -> localhost | |+o.= . | 2025-01-21 09:27:12.021533 | ubuntu-noble -> localhost | | .oE+ . | 2025-01-21 09:27:12.021549 | ubuntu-noble -> localhost | |.o. o o . | 2025-01-21 09:27:12.021564 | ubuntu-noble -> localhost | |o o O S o . | 2025-01-21 09:27:12.021579 | ubuntu-noble -> localhost | | . . = + = . . | 2025-01-21 09:27:12.021595 | ubuntu-noble -> localhost | | . B B . o | 2025-01-21 09:27:12.021610 | ubuntu-noble -> localhost | | = O.o.= | 2025-01-21 09:27:12.021625 | ubuntu-noble -> localhost | | ..ooB=+ . | 2025-01-21 09:27:12.021640 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-21 09:27:12.021680 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.128692 2025-01-21 09:27:12.028665 | 2025-01-21 09:27:12.028757 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-21 09:27:12.050985 | ubuntu-noble | ok 2025-01-21 09:27:12.059737 | ubuntu-noble | included: /var/lib/zuul/builds/499dc3fbc0a34a7289def8e76b38317a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-21 09:27:12.067465 | 2025-01-21 09:27:12.067539 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-21 09:27:12.085903 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:12.091893 | 2025-01-21 09:27:12.091974 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-21 09:27:12.923743 | ubuntu-noble | changed 2025-01-21 09:27:12.930668 | 2025-01-21 09:27:12.930758 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-21 09:27:13.246868 | ubuntu-noble | ok 2025-01-21 09:27:13.254403 | 2025-01-21 09:27:13.254496 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-21 09:27:14.000799 | ubuntu-noble | changed 2025-01-21 09:27:14.015333 | 2025-01-21 09:27:14.015498 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-21 09:27:14.706452 | ubuntu-noble | changed 2025-01-21 09:27:14.713667 | 2025-01-21 09:27:14.713763 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-21 09:27:14.737517 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:14.745044 | 2025-01-21 09:27:14.745134 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-21 09:27:15.257389 | ubuntu-noble -> localhost | changed 2025-01-21 09:27:15.272271 | 2025-01-21 09:27:15.272400 | TASK [add-build-sshkey : Add back temp key] 2025-01-21 09:27:15.853009 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/499dc3fbc0a34a7289def8e76b38317a/work/499dc3fbc0a34a7289def8e76b38317a_id_rsa (zuul-build-sshkey) 2025-01-21 09:27:15.853213 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.025289 2025-01-21 09:27:15.859832 | 2025-01-21 09:27:15.859932 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-21 09:27:16.268326 | ubuntu-noble | ok 2025-01-21 09:27:16.279473 | 2025-01-21 09:27:16.279585 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-21 09:27:16.323768 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 09:27:16.342284 | 2025-01-21 09:27:16.342404 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-21 09:27:16.780242 | ubuntu-noble | ok 2025-01-21 09:27:16.792734 | 2025-01-21 09:27:16.792831 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-21 09:27:16.822396 | ubuntu-noble | ok 2025-01-21 09:27:16.828680 | 2025-01-21 09:27:16.828772 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-21 09:27:17.065879 | ubuntu-noble -> localhost | ok 2025-01-21 09:27:17.073104 | 2025-01-21 09:27:17.073196 | TASK [validate-host : Collect information about the host] 2025-01-21 09:27:18.266883 | ubuntu-noble | ok 2025-01-21 09:27:18.278713 | 2025-01-21 09:27:18.278811 | TASK [validate-host : Sanitize hostname] 2025-01-21 09:27:18.348261 | ubuntu-noble | ok 2025-01-21 09:27:18.358441 | 2025-01-21 09:27:18.358538 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-21 09:27:18.993281 | ubuntu-noble -> localhost | changed 2025-01-21 09:27:18.999941 | 2025-01-21 09:27:19.000042 | TASK [validate-host : Collect information about zuul worker] 2025-01-21 09:27:19.579522 | ubuntu-noble | ok 2025-01-21 09:27:19.585565 | 2025-01-21 09:27:19.585662 | TASK [validate-host : Write out all zuul information for each host] 2025-01-21 09:27:20.073155 | ubuntu-noble -> localhost | changed 2025-01-21 09:27:20.085528 | 2025-01-21 09:27:20.085625 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-21 09:27:20.413328 | ubuntu-noble | ok 2025-01-21 09:27:20.420553 | 2025-01-21 09:27:20.420648 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-21 09:27:21.607931 | ubuntu-noble | changed: 2025-01-21 09:27:21.608153 | ubuntu-noble | cd+++++++++ src/ 2025-01-21 09:27:21.608193 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-21 09:27:21.608251 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-21 09:27:21.608334 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-01-21 09:27:21.608428 | ubuntu-noble | Containerfile 2025-01-21 09:27:21.608958 | ubuntu-noble | =35.0.0 in /tmp/venv/lib/python3.12/site-packages (from types-redis) (44.0.0) 2025-01-21 09:29:07.390029 | ubuntu-noble | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-21 09:29:07.416773 | 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-21 09:29:07.479656 | ubuntu-noble | Collecting types-cffi (from types-pyOpenSSL->types-redis) 2025-01-21 09:29:07.495901 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl.metadata (1.8 kB) 2025-01-21 09:29:07.512916 | 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-21 09:29:07.609572 | ubuntu-noble | Collecting types-setuptools (from types-cffi->types-pyOpenSSL->types-redis) 2025-01-21 09:29:07.622225 | ubuntu-noble | Downloading types_setuptools-75.8.0.20250110-py3-none-any.whl.metadata (2.2 kB) 2025-01-21 09:29:07.659740 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-21 09:29:07.686267 | ubuntu-noble | Downloading types_decorator-5.1.8.20250121-py3-none-any.whl (8.1 kB) 2025-01-21 09:29:07.713455 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-01-21 09:29:07.738755 | ubuntu-noble | Downloading types_pytz-2024.2.0.20241221-py3-none-any.whl (10 kB) 2025-01-21 09:29:07.767492 | ubuntu-noble | Downloading types_redis-4.6.0.20241004-py3-none-any.whl (58 kB) 2025-01-21 09:29:07.796335 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.7/58.7 kB 2.4 MB/s eta 0:00:00 2025-01-21 09:29:07.812253 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-21 09:29:07.842008 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-21 09:29:07.871395 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-21 09:29:07.899062 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-01-21 09:29:07.927159 | ubuntu-noble | Downloading types_pyOpenSSL-24.1.0.20240722-py3-none-any.whl (7.5 kB) 2025-01-21 09:29:07.953835 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl (19 kB) 2025-01-21 09:29:07.980445 | ubuntu-noble | Downloading types_setuptools-75.8.0.20250110-py3-none-any.whl (71 kB) 2025-01-21 09:29:07.999609 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.5/71.5 kB 5.2 MB/s eta 0:00:00 2025-01-21 09:29:08.847786 | 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-21 09:29:09.393689 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-cffi-1.16.0.20241221 types-decorator-5.1.8.20250121 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-21 09:29:18.898479 | ubuntu-noble | Installing missing stub packages: 2025-01-21 09:29:18.917105 | 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-21 09:29:18.917142 | ubuntu-noble | 2025-01-21 09:29:18.917147 | ubuntu-noble | 2025-01-21 09:29:18.917151 | ubuntu-noble | Success: no issues found in 55 source files 2025-01-21 09:29:19.314493 | ubuntu-noble | ok 2025-01-21 09:29:19.362629 | 2025-01-21 09:29:19.362756 | PLAY RECAP 2025-01-21 09:29:19.362824 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-21 09:29:19.362857 | 2025-01-21 09:29:19.491232 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-21 09:29:19.497255 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-21 09:29:20.238036 | 2025-01-21 09:29:20.238216 | PLAY [Base post] 2025-01-21 09:29:20.263940 | 2025-01-21 09:29:20.264071 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-21 09:29:20.838771 | ubuntu-noble | changed 2025-01-21 09:29:20.878923 | 2025-01-21 09:29:20.879079 | PLAY RECAP 2025-01-21 09:29:20.879147 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-21 09:29:20.879222 | 2025-01-21 09:29:20.997517 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-21 09:29:21.004359 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-21 09:29:21.794261 | 2025-01-21 09:29:21.794443 | PLAY [Base post-logs] 2025-01-21 09:29:21.811267 | 2025-01-21 09:29:21.811411 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-21 09:29:22.303355 | localhost | changed 2025-01-21 09:29:22.309289 | 2025-01-21 09:29:22.309461 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-21 09:29:22.353135 | localhost | ok 2025-01-21 09:29:22.365475 | 2025-01-21 09:29:22.365654 | TASK [Set zuul-log-path fact] 2025-01-21 09:29:22.399252 | localhost | ok 2025-01-21 09:29:22.419429 | 2025-01-21 09:29:22.419568 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 09:29:22.473314 | localhost | ok 2025-01-21 09:29:22.481301 | 2025-01-21 09:29:22.481486 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 09:29:22.519339 | localhost | skipping: Conditional result was False 2025-01-21 09:29:22.528957 | 2025-01-21 09:29:22.529157 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 09:29:22.590496 | localhost | skipping: Conditional result was False 2025-01-21 09:29:22.599018 | 2025-01-21 09:29:22.599280 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 09:29:22.625854 | localhost | skipping: Conditional result was False 2025-01-21 09:29:22.635201 | 2025-01-21 09:29:22.635444 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 09:29:22.662595 | localhost | skipping: Conditional result was False 2025-01-21 09:29:22.672465 | 2025-01-21 09:29:22.672686 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 09:29:22.699413 | localhost | skipping: Conditional result was False 2025-01-21 09:29:22.715515 | 2025-01-21 09:29:22.715695 | TASK [upload-logs : Create log directories] 2025-01-21 09:29:23.227414 | localhost | changed 2025-01-21 09:29:23.232961 | 2025-01-21 09:29:23.233185 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-21 09:29:23.758655 | localhost -> localhost | ok: Runtime: 0:00:00.005867 2025-01-21 09:29:23.764078 | 2025-01-21 09:29:23.764475 | TASK [upload-logs : Upload logs to log server] 2025-01-21 09:29:24.320248 | localhost | Output suppressed because no_log was given 2025-01-21 09:29:24.326072 | 2025-01-21 09:29:24.326229 | LOOP [upload-logs : Compress console log and json output] 2025-01-21 09:29:24.393073 | localhost | skipping: Conditional result was False 2025-01-21 09:29:24.410650 | localhost | skipping: Conditional result was False 2025-01-21 09:29:24.424760 | 2025-01-21 09:29:24.424942 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-21 09:29:24.489585 | localhost | skipping: Conditional result was False 2025-01-21 09:29:24.490347 | 2025-01-21 09:29:24.501752 | localhost | skipping: Conditional result was False 2025-01-21 09:29:24.511193 | 2025-01-21 09:29:24.511355 | LOOP [upload-logs : Upload console log and json output]