2025-06-01 09:14:50.621622 | Job console starting 2025-06-01 09:14:50.638036 | Updating git repos 2025-06-01 09:14:50.756701 | Cloning repos into workspace 2025-06-01 09:14:50.845839 | Restoring repo states 2025-06-01 09:14:50.858996 | Merging changes 2025-06-01 09:14:51.415987 | Checking out repos 2025-06-01 09:14:51.459653 | Preparing playbooks 2025-06-01 09:14:52.447216 | Running Ansible setup 2025-06-01 09:14:57.395515 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-01 09:14:58.233910 | 2025-06-01 09:14:58.234086 | PLAY [Base pre] 2025-06-01 09:14:58.250970 | 2025-06-01 09:14:58.251133 | TASK [Setup log path fact] 2025-06-01 09:14:58.270644 | debian-bookworm | ok 2025-06-01 09:14:58.287845 | 2025-06-01 09:14:58.288014 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 09:14:58.318349 | debian-bookworm | ok 2025-06-01 09:14:58.332146 | 2025-06-01 09:14:58.332282 | TASK [emit-job-header : Print job information] 2025-06-01 09:14:58.371657 | # Job Information 2025-06-01 09:14:58.371846 | Ansible Version: 2.16.14 2025-06-01 09:14:58.371882 | Job: mypy 2025-06-01 09:14:58.371916 | Pipeline: check 2025-06-01 09:14:58.371939 | Executor: 521e9411259a 2025-06-01 09:14:58.371960 | Triggered by: https://github.com/osism/python-osism/pull/1382 2025-06-01 09:14:58.371982 | Event ID: d970b930-3ec8-11f0-902b-6d891d877cf4 2025-06-01 09:14:58.382982 | 2025-06-01 09:14:58.383123 | LOOP [emit-job-header : Print node information] 2025-06-01 09:14:58.553892 | debian-bookworm | ok: 2025-06-01 09:14:58.554101 | debian-bookworm | # Node Information 2025-06-01 09:14:58.554136 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-01 09:14:58.554161 | debian-bookworm | Hostname: debian 2025-06-01 09:14:58.554183 | debian-bookworm | Username: zuul 2025-06-01 09:14:58.554204 | debian-bookworm | Distro: Debian 12.11 2025-06-01 09:14:58.554227 | debian-bookworm | Provider: regiocloud-a 2025-06-01 09:14:58.554247 | debian-bookworm | Region: 2025-06-01 09:14:58.554268 | debian-bookworm | Label: debian-bookworm 2025-06-01 09:14:58.554288 | debian-bookworm | Product Name: OpenStack Nova 2025-06-01 09:14:58.554307 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1c:9cb 2025-06-01 09:14:58.574264 | 2025-06-01 09:14:58.574395 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-01 09:14:59.460219 | debian-bookworm -> localhost | changed 2025-06-01 09:14:59.468038 | 2025-06-01 09:14:59.468177 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-01 09:15:01.189905 | debian-bookworm -> localhost | changed 2025-06-01 09:15:01.216387 | 2025-06-01 09:15:01.218014 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-01 09:15:01.825695 | debian-bookworm -> localhost | ok 2025-06-01 09:15:01.832069 | 2025-06-01 09:15:01.832201 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-01 09:15:01.893359 | debian-bookworm | ok 2025-06-01 09:15:01.922757 | debian-bookworm | included: /var/lib/zuul/builds/c21f01f007c949bc9593e963694cc2d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-01 09:15:01.947014 | 2025-06-01 09:15:01.947257 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-01 09:15:03.187335 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-01 09:15:03.187662 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c21f01f007c949bc9593e963694cc2d1/work/c21f01f007c949bc9593e963694cc2d1_id_rsa 2025-06-01 09:15:03.187706 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c21f01f007c949bc9593e963694cc2d1/work/c21f01f007c949bc9593e963694cc2d1_id_rsa.pub 2025-06-01 09:15:03.187734 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-01 09:15:03.187760 | debian-bookworm -> localhost | SHA256:BsAlxSo83TpiWJUWlShQ45SQ3ejc/peqmz5hEfeiHLw zuul-build-sshkey 2025-06-01 09:15:03.187784 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-01 09:15:03.187817 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-01 09:15:03.187840 | debian-bookworm -> localhost | |o*+=+O+. | 2025-06-01 09:15:03.187861 | debian-bookworm -> localhost | |.o=.Oo+ | 2025-06-01 09:15:03.187881 | debian-bookworm -> localhost | | +.B =.. | 2025-06-01 09:15:03.187900 | debian-bookworm -> localhost | | B B o.. | 2025-06-01 09:15:03.187920 | debian-bookworm -> localhost | | o = * .S | 2025-06-01 09:15:03.187946 | debian-bookworm -> localhost | |. o E . | 2025-06-01 09:15:03.187966 | debian-bookworm -> localhost | | . o + . | 2025-06-01 09:15:03.187987 | debian-bookworm -> localhost | | ... o | 2025-06-01 09:15:03.188008 | debian-bookworm -> localhost | | .=+.o | 2025-06-01 09:15:03.188028 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-01 09:15:03.188087 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.405495 2025-06-01 09:15:03.197509 | 2025-06-01 09:15:03.197644 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-01 09:15:03.249685 | debian-bookworm | ok 2025-06-01 09:15:03.280150 | debian-bookworm | included: /var/lib/zuul/builds/c21f01f007c949bc9593e963694cc2d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-01 09:15:03.305173 | 2025-06-01 09:15:03.305316 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-01 09:15:03.331128 | debian-bookworm | skipping: Conditional result was False 2025-06-01 09:15:03.337384 | 2025-06-01 09:15:03.337552 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-01 09:15:04.125081 | debian-bookworm | changed 2025-06-01 09:15:04.130629 | 2025-06-01 09:15:04.130751 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-01 09:15:04.395330 | debian-bookworm | ok 2025-06-01 09:15:04.401070 | 2025-06-01 09:15:04.401188 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-01 09:15:05.166495 | debian-bookworm | changed 2025-06-01 09:15:05.184012 | 2025-06-01 09:15:05.184161 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-01 09:15:05.800947 | debian-bookworm | changed 2025-06-01 09:15:05.808342 | 2025-06-01 09:15:05.808481 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-01 09:15:05.832799 | debian-bookworm | skipping: Conditional result was False 2025-06-01 09:15:05.839141 | 2025-06-01 09:15:05.839263 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-01 09:15:06.326465 | debian-bookworm -> localhost | changed 2025-06-01 09:15:06.337806 | 2025-06-01 09:15:06.337924 | TASK [add-build-sshkey : Add back temp key] 2025-06-01 09:15:06.755868 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c21f01f007c949bc9593e963694cc2d1/work/c21f01f007c949bc9593e963694cc2d1_id_rsa (zuul-build-sshkey) 2025-06-01 09:15:06.756189 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011719 2025-06-01 09:15:06.764877 | 2025-06-01 09:15:06.772077 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-01 09:15:07.199764 | debian-bookworm | ok 2025-06-01 09:15:07.206421 | 2025-06-01 09:15:07.206585 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-01 09:15:07.240712 | debian-bookworm | skipping: Conditional result was False 2025-06-01 09:15:07.252201 | 2025-06-01 09:15:07.252336 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-01 09:15:07.704912 | debian-bookworm | ok 2025-06-01 09:15:07.722791 | 2025-06-01 09:15:07.722952 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-01 09:15:07.764225 | debian-bookworm | ok 2025-06-01 09:15:07.770017 | 2025-06-01 09:15:07.770133 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-01 09:15:08.154550 | debian-bookworm -> localhost | ok 2025-06-01 09:15:08.161220 | 2025-06-01 09:15:08.161351 | TASK [validate-host : Collect information about the host] 2025-06-01 09:15:09.298215 | debian-bookworm | ok 2025-06-01 09:15:09.308526 | 2025-06-01 09:15:09.308652 | TASK [validate-host : Sanitize hostname] 2025-06-01 09:15:09.447113 | debian-bookworm | ok 2025-06-01 09:15:09.495406 | 2025-06-01 09:15:09.495560 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-01 09:15:10.141386 | debian-bookworm -> localhost | changed 2025-06-01 09:15:10.147621 | 2025-06-01 09:15:10.147747 | TASK [validate-host : Collect information about zuul worker] 2025-06-01 09:15:10.565229 | debian-bookworm | ok 2025-06-01 09:15:10.576935 | 2025-06-01 09:15:10.577090 | TASK [validate-host : Write out all zuul information for each host] 2025-06-01 09:15:11.275529 | debian-bookworm -> localhost | changed 2025-06-01 09:15:11.285565 | 2025-06-01 09:15:11.285687 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-01 09:15:11.559944 | debian-bookworm | ok 2025-06-01 09:15:11.567276 | 2025-06-01 09:15:11.567414 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-01 09:15:12.574081 | debian-bookworm | changed: 2025-06-01 09:15:12.574288 | debian-bookworm | cd+++++++++ src/ 2025-06-01 09:15:12.574323 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-01 09:15:12.574347 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-01 09:15:12.574368 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-01 09:15:12.574389 | debian-bookworm | Containerfile 2025-06-01 09:15:12.574528 | debian-bookworm | =35.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-pyOpenSSL) (45.0.3) 2025-06-01 09:16:35.570317 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.4.0) 2025-06-01 09:16:35.596866 | debian-bookworm | Requirement already satisfied: cffi>=1.14 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=35.0.0->types-pyOpenSSL) (1.17.1) 2025-06-01 09:16:35.672321 | debian-bookworm | Collecting types-setuptools 2025-06-01 09:16:35.681582 | debian-bookworm | Downloading types_setuptools-80.9.0.20250529-py3-none-any.whl (63 kB) 2025-06-01 09:16:35.691901 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.3/63.3 kB 7.4 MB/s eta 0:00:00 2025-06-01 09:16:35.696821 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=1.14->cryptography>=35.0.0->types-pyOpenSSL) (2.22) 2025-06-01 09:16:36.455209 | debian-bookworm | 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-06-01 09:16:36.818092 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20250516 types-cffi-1.17.0.20250523 types-decorator-5.2.0.20250324 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20250516 types-pytz-2025.2.0.20250516 types-requests-2.32.0.20250515 types-setuptools-80.9.0.20250529 types-simplejson-3.20.0.20250326 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250326 2025-06-01 09:16:43.520689 | debian-bookworm | osism/services/listener.py:139: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-06-01 09:16:43.520800 | debian-bookworm | osism/services/listener.py:140: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-06-01 09:16:43.520832 | debian-bookworm | Installing missing stub packages: 2025-06-01 09:16:43.520847 | debian-bookworm | /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-06-01 09:16:43.520863 | debian-bookworm | 2025-06-01 09:16:43.520876 | debian-bookworm | 2025-06-01 09:16:43.520888 | debian-bookworm | Success: no issues found in 49 source files 2025-06-01 09:16:43.921273 | debian-bookworm | ok: Runtime: 0:00:24.900703 2025-06-01 09:16:43.935167 | 2025-06-01 09:16:43.935280 | PLAY RECAP 2025-06-01 09:16:43.935354 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-06-01 09:16:43.935410 | 2025-06-01 09:16:44.072767 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-06-01 09:16:44.075030 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-01 09:16:44.838490 | 2025-06-01 09:16:44.838684 | PLAY [Base post] 2025-06-01 09:16:44.853738 | 2025-06-01 09:16:44.853906 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-01 09:16:45.402520 | debian-bookworm | changed 2025-06-01 09:16:45.414752 | 2025-06-01 09:16:45.414922 | PLAY RECAP 2025-06-01 09:16:45.415162 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-01 09:16:45.415229 | 2025-06-01 09:16:45.581016 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-01 09:16:45.582450 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-01 09:16:46.413215 | 2025-06-01 09:16:46.413404 | PLAY [Base post-logs] 2025-06-01 09:16:46.424086 | 2025-06-01 09:16:46.424255 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-01 09:16:46.898521 | localhost | changed 2025-06-01 09:16:46.913712 | 2025-06-01 09:16:46.913890 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-01 09:16:46.953262 | localhost | ok 2025-06-01 09:16:46.957690 | 2025-06-01 09:16:46.957835 | TASK [Set zuul-log-path fact] 2025-06-01 09:16:46.975825 | localhost | ok 2025-06-01 09:16:46.985164 | 2025-06-01 09:16:46.985293 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 09:16:47.021916 | localhost | ok 2025-06-01 09:16:47.026038 | 2025-06-01 09:16:47.026169 | TASK [upload-logs : Create log directories] 2025-06-01 09:16:47.615781 | localhost | changed 2025-06-01 09:16:47.620634 | 2025-06-01 09:16:47.620795 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-01 09:16:48.152688 | localhost -> localhost | ok: Runtime: 0:00:00.007528 2025-06-01 09:16:48.156809 | 2025-06-01 09:16:48.156921 | TASK [upload-logs : Upload logs to log server] 2025-06-01 09:16:48.756130 | localhost | Output suppressed because no_log was given 2025-06-01 09:16:48.759722 | 2025-06-01 09:16:48.759855 | LOOP [upload-logs : Compress console log and json output] 2025-06-01 09:16:48.825974 | localhost | skipping: Conditional result was False 2025-06-01 09:16:48.834101 | localhost | skipping: Conditional result was False 2025-06-01 09:16:48.839609 | 2025-06-01 09:16:48.839725 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-01 09:16:48.904146 | localhost | skipping: Conditional result was False 2025-06-01 09:16:48.904758 | 2025-06-01 09:16:48.908502 | localhost | skipping: Conditional result was False 2025-06-01 09:16:48.921130 | 2025-06-01 09:16:48.921343 | LOOP [upload-logs : Upload console log and json output]