2026-05-27 16:58:26.517252 | Job console starting 2026-05-27 16:58:26.542733 | Updating git repos 2026-05-27 16:58:26.606023 | Cloning repos into workspace 2026-05-27 16:58:26.652337 | Restoring repo states 2026-05-27 16:58:26.669283 | Merging changes 2026-05-27 16:58:27.409664 | Checking out repos 2026-05-27 16:58:27.495100 | Preparing playbooks 2026-05-27 16:58:28.919639 | Running Ansible setup 2026-05-27 16:58:35.508410 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-27 16:58:36.391192 | 2026-05-27 16:58:36.391357 | PLAY [Base pre] 2026-05-27 16:58:36.417786 | 2026-05-27 16:58:36.417908 | TASK [Setup log path fact] 2026-05-27 16:58:36.446886 | debian-bookworm | ok 2026-05-27 16:58:36.474690 | 2026-05-27 16:58:36.474821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 16:58:36.507113 | debian-bookworm | ok 2026-05-27 16:58:36.528621 | 2026-05-27 16:58:36.528729 | TASK [emit-job-header : Print job information] 2026-05-27 16:58:36.622492 | # Job Information 2026-05-27 16:58:36.622642 | Ansible Version: 2.16.14 2026-05-27 16:58:36.622678 | Job: mypy 2026-05-27 16:58:36.622710 | Pipeline: check 2026-05-27 16:58:36.622733 | Executor: 521e9411259a 2026-05-27 16:58:36.622754 | Triggered by: https://github.com/osism/python-osism/pull/2305 2026-05-27 16:58:36.622776 | Event ID: 41a8aa90-59ed-11f1-957c-e19a4d552fd6 2026-05-27 16:58:36.633606 | 2026-05-27 16:58:36.633718 | LOOP [emit-job-header : Print node information] 2026-05-27 16:58:36.959508 | debian-bookworm | ok: 2026-05-27 16:58:36.959672 | debian-bookworm | # Node Information 2026-05-27 16:58:36.959710 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-27 16:58:36.959738 | debian-bookworm | Hostname: debian 2026-05-27 16:58:36.960099 | debian-bookworm | Username: zuul 2026-05-27 16:58:36.960304 | debian-bookworm | Distro: Debian 12.14 2026-05-27 16:58:36.960350 | debian-bookworm | Provider: regiocloud-a 2026-05-27 16:58:36.960423 | debian-bookworm | Region: 2026-05-27 16:58:36.961097 | debian-bookworm | Label: debian-bookworm 2026-05-27 16:58:36.961408 | debian-bookworm | Product Name: OpenStack Nova 2026-05-27 16:58:36.961441 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9a:34de 2026-05-27 16:58:36.978503 | 2026-05-27 16:58:36.978594 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-27 16:58:38.015861 | debian-bookworm -> localhost | changed 2026-05-27 16:58:38.021469 | 2026-05-27 16:58:38.021560 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-27 16:58:41.055485 | debian-bookworm -> localhost | changed 2026-05-27 16:58:41.064379 | 2026-05-27 16:58:41.064504 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-27 16:58:41.923799 | debian-bookworm -> localhost | ok 2026-05-27 16:58:41.928971 | 2026-05-27 16:58:41.929067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-27 16:58:41.984702 | debian-bookworm | ok 2026-05-27 16:58:42.011515 | debian-bookworm | included: /var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-27 16:58:42.021460 | 2026-05-27 16:58:42.021549 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-27 16:58:44.863513 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-27 16:58:44.863675 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/42d0904be20541e7b5f856cd4882aac1_id_rsa 2026-05-27 16:58:44.863707 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/42d0904be20541e7b5f856cd4882aac1_id_rsa.pub 2026-05-27 16:58:44.863729 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-27 16:58:44.863750 | debian-bookworm -> localhost | SHA256:XHGQr5fMNzMENmhks4IoiML6QdK4ZHVHdfxUaFFY/Go zuul-build-sshkey 2026-05-27 16:58:44.863769 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-27 16:58:44.863792 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-27 16:58:44.863811 | debian-bookworm -> localhost | | . ..o.oB=..O+ | 2026-05-27 16:58:44.863829 | debian-bookworm -> localhost | |o+. .... .=*+= . | 2026-05-27 16:58:44.863845 | debian-bookworm -> localhost | |*++ . . ..oo+o .| 2026-05-27 16:58:44.863862 | debian-bookworm -> localhost | |=+ . . o ... .| 2026-05-27 16:58:44.863878 | debian-bookworm -> localhost | |o . S + o . | 2026-05-27 16:58:44.863900 | debian-bookworm -> localhost | | . . . = E | 2026-05-27 16:58:44.863917 | debian-bookworm -> localhost | | . . o + | 2026-05-27 16:58:44.863935 | debian-bookworm -> localhost | | | 2026-05-27 16:58:44.863952 | debian-bookworm -> localhost | | | 2026-05-27 16:58:44.863968 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-27 16:58:44.864011 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.367741 2026-05-27 16:58:44.869251 | 2026-05-27 16:58:44.869325 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-27 16:58:44.905857 | debian-bookworm | ok 2026-05-27 16:58:44.921340 | debian-bookworm | included: /var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-27 16:58:44.946585 | 2026-05-27 16:58:44.946685 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-27 16:58:44.996223 | debian-bookworm | skipping: Conditional result was False 2026-05-27 16:58:45.001445 | 2026-05-27 16:58:45.001533 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-27 16:58:45.906889 | debian-bookworm | changed 2026-05-27 16:58:45.911279 | 2026-05-27 16:58:45.911357 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-27 16:58:46.227379 | debian-bookworm | ok 2026-05-27 16:58:46.231916 | 2026-05-27 16:58:46.231994 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-27 16:58:47.080627 | debian-bookworm | changed 2026-05-27 16:58:47.086441 | 2026-05-27 16:58:47.086534 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-27 16:58:47.887915 | debian-bookworm | changed 2026-05-27 16:58:47.894277 | 2026-05-27 16:58:47.894357 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-27 16:58:47.929935 | debian-bookworm | skipping: Conditional result was False 2026-05-27 16:58:47.936768 | 2026-05-27 16:58:47.936852 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-27 16:58:48.619118 | debian-bookworm -> localhost | changed 2026-05-27 16:58:48.630378 | 2026-05-27 16:58:48.630466 | TASK [add-build-sshkey : Add back temp key] 2026-05-27 16:58:49.230608 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/42d0904be20541e7b5f856cd4882aac1_id_rsa (zuul-build-sshkey) 2026-05-27 16:58:49.230789 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019732 2026-05-27 16:58:49.237084 | 2026-05-27 16:58:49.237177 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-27 16:58:49.784634 | debian-bookworm | ok 2026-05-27 16:58:49.788860 | 2026-05-27 16:58:49.788950 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-27 16:58:49.821731 | debian-bookworm | skipping: Conditional result was False 2026-05-27 16:58:49.831185 | 2026-05-27 16:58:49.831291 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-27 16:58:50.559925 | debian-bookworm | ok 2026-05-27 16:58:50.575542 | 2026-05-27 16:58:50.575633 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-27 16:58:50.627716 | debian-bookworm | ok 2026-05-27 16:58:50.631792 | 2026-05-27 16:58:50.631868 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-27 16:58:51.430629 | debian-bookworm -> localhost | ok 2026-05-27 16:58:51.436009 | 2026-05-27 16:58:51.436088 | TASK [validate-host : Collect information about the host] 2026-05-27 16:58:52.765658 | debian-bookworm | ok 2026-05-27 16:58:52.781330 | 2026-05-27 16:58:52.781433 | TASK [validate-host : Sanitize hostname] 2026-05-27 16:58:52.979430 | debian-bookworm | ok 2026-05-27 16:58:53.120091 | 2026-05-27 16:58:53.120206 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-27 16:58:54.937783 | debian-bookworm -> localhost | changed 2026-05-27 16:58:54.943840 | 2026-05-27 16:58:54.943948 | TASK [validate-host : Collect information about zuul worker] 2026-05-27 16:58:55.779512 | debian-bookworm | ok 2026-05-27 16:58:55.790889 | 2026-05-27 16:58:55.791012 | TASK [validate-host : Write out all zuul information for each host] 2026-05-27 16:58:57.111015 | debian-bookworm -> localhost | changed 2026-05-27 16:58:57.119839 | 2026-05-27 16:58:57.119930 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-27 16:58:57.435895 | debian-bookworm | ok 2026-05-27 16:58:57.440283 | 2026-05-27 16:58:57.440356 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-27 16:58:59.308716 | debian-bookworm | changed: 2026-05-27 16:58:59.308867 | debian-bookworm | cd+++++++++ src/ 2026-05-27 16:58:59.308894 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-27 16:58:59.308914 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-27 16:58:59.308931 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-27 16:58:59.308948 | debian-bookworm | Containerfile 2026-05-27 16:58:59.309054 | debian-bookworm | Containerfile 2026-05-27 16:58:59.314516 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (48.0.0) 2026-05-27 17:00:32.540145 | debian-bookworm | Requirement already satisfied: cffi>=2.0.0 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=37.0.0->types-paramiko) (2.0.0) 2026-05-27 17:00:32.544698 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=2.0.0->cryptography>=37.0.0->types-paramiko) (3.0) 2026-05-27 17:00:33.362433 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-PyYAML, types-pytz, types-python-dateutil, types-PyMySQL, types-paramiko 2026-05-27 17:00:33.702247 | debian-bookworm | Successfully installed types-PyMySQL-1.1.0.20260518 types-PyYAML-6.0.12.20260518 types-paramiko-4.0.0.20260518 types-python-dateutil-2.9.0.20260518 types-pytz-2026.2.0.20260518 types-simplejson-3.20.0.20260518 types-tabulate-0.10.0.20260508 2026-05-27 17:00:38.415953 | debian-bookworm | tests/conftest.py:95: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416000 | debian-bookworm | tests/unit/test_settings.py:45: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416014 | debian-bookworm | osism/services/websocket_manager.py:87: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416031 | debian-bookworm | osism/services/websocket_manager.py:89: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416042 | debian-bookworm | osism/services/websocket_manager.py:91: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416054 | debian-bookworm | osism/tasks/conductor/sonic/cache.py:16: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416066 | debian-bookworm | osism/services/listener.py:181: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416090 | debian-bookworm | osism/services/listener.py:182: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416102 | debian-bookworm | osism/services/listener.py:184: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416113 | debian-bookworm | osism/services/listener.py:185: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416124 | debian-bookworm | osism/services/listener.py:488: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416143 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:342: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416154 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:397: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416165 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:436: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-27 17:00:38.416195 | debian-bookworm | Installing missing stub packages: 2026-05-27 17:00:38.416200 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyMySQL types-PyYAML types-paramiko types-python-dateutil types-pytz types-simplejson types-tabulate 2026-05-27 17:00:38.416204 | debian-bookworm | 2026-05-27 17:00:38.416207 | debian-bookworm | 2026-05-27 17:00:38.416211 | debian-bookworm | Success: no issues found in 125 source files 2026-05-27 17:00:38.871699 | debian-bookworm | ok: Runtime: 0:00:21.315480 2026-05-27 17:00:38.884814 | 2026-05-27 17:00:38.884924 | PLAY RECAP 2026-05-27 17:00:38.884999 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-05-27 17:00:38.885031 | 2026-05-27 17:00:39.064985 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-27 17:00:39.065937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-27 17:00:39.943058 | 2026-05-27 17:00:39.943227 | PLAY [Base post-fetch] 2026-05-27 17:00:39.964543 | 2026-05-27 17:00:39.964705 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-27 17:00:40.020709 | debian-bookworm | skipping: Conditional result was False 2026-05-27 17:00:40.027784 | 2026-05-27 17:00:40.027971 | TASK [fetch-output : Set log path for single node] 2026-05-27 17:00:40.071082 | debian-bookworm | ok 2026-05-27 17:00:40.077409 | 2026-05-27 17:00:40.077538 | LOOP [fetch-output : Ensure local output dirs] 2026-05-27 17:00:40.633225 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/logs" 2026-05-27 17:00:40.931813 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/artifacts" 2026-05-27 17:00:41.226059 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/42d0904be20541e7b5f856cd4882aac1/work/docs" 2026-05-27 17:00:41.242041 | 2026-05-27 17:00:41.242334 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-27 17:00:42.076499 | debian-bookworm | changed: 2026-05-27 17:00:42.076776 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-27 17:00:42.076819 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-27 17:00:42.076862 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-27 17:00:42.076914 | debian-bookworm | changed: All items complete 2026-05-27 17:00:42.076943 | 2026-05-27 17:00:42.677594 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 17:00:43.267646 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 17:00:43.301552 | 2026-05-27 17:00:43.301845 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-27 17:00:43.885326 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006854 2026-05-27 17:00:44.171242 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011601 2026-05-27 17:00:44.189372 | 2026-05-27 17:00:44.189511 | PLAY RECAP 2026-05-27 17:00:44.189591 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-27 17:00:44.189633 | 2026-05-27 17:00:44.333352 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-27 17:00:44.334192 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 17:00:45.116980 | 2026-05-27 17:00:45.117170 | PLAY [Base post] 2026-05-27 17:00:45.132960 | 2026-05-27 17:00:45.133119 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-27 17:00:45.757731 | debian-bookworm | changed 2026-05-27 17:00:45.769556 | 2026-05-27 17:00:45.769714 | PLAY RECAP 2026-05-27 17:00:45.769796 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-27 17:00:45.769875 | 2026-05-27 17:00:45.905129 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 17:00:45.905985 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-27 17:00:46.746118 | 2026-05-27 17:00:46.746329 | PLAY [Base post-logs] 2026-05-27 17:00:46.757334 | 2026-05-27 17:00:46.757489 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-27 17:00:47.219329 | localhost | changed 2026-05-27 17:00:47.229968 | 2026-05-27 17:00:47.230153 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-27 17:00:47.278028 | localhost | ok 2026-05-27 17:00:47.283149 | 2026-05-27 17:00:47.283313 | TASK [Set zuul-log-path fact] 2026-05-27 17:00:47.302817 | localhost | ok 2026-05-27 17:00:47.311050 | 2026-05-27 17:00:47.311174 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 17:00:47.347027 | localhost | ok 2026-05-27 17:00:47.350516 | 2026-05-27 17:00:47.350635 | TASK [upload-logs : Create log directories] 2026-05-27 17:00:47.956008 | localhost | changed 2026-05-27 17:00:47.959222 | 2026-05-27 17:00:47.959357 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-27 17:00:48.527852 | localhost -> localhost | ok: Runtime: 0:00:00.005064 2026-05-27 17:00:48.537303 | 2026-05-27 17:00:48.537497 | TASK [upload-logs : Upload logs to log server] 2026-05-27 17:00:49.095164 | localhost | Output suppressed because no_log was given 2026-05-27 17:00:49.097061 | 2026-05-27 17:00:49.097171 | LOOP [upload-logs : Compress console log and json output] 2026-05-27 17:00:49.146603 | localhost | skipping: Conditional result was False 2026-05-27 17:00:49.152736 | localhost | skipping: Conditional result was False 2026-05-27 17:00:49.161061 | 2026-05-27 17:00:49.161201 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-27 17:00:49.206858 | localhost | skipping: Conditional result was False 2026-05-27 17:00:49.207173 | 2026-05-27 17:00:49.212141 | localhost | skipping: Conditional result was False 2026-05-27 17:00:49.218110 | 2026-05-27 17:00:49.218232 | LOOP [upload-logs : Upload console log and json output]