2026-05-19 14:42:07.000020 | Job console starting 2026-05-19 14:42:07.053509 | Updating git repos 2026-05-19 14:42:07.126085 | Cloning repos into workspace 2026-05-19 14:42:07.245600 | Restoring repo states 2026-05-19 14:42:07.267755 | Merging changes 2026-05-19 14:42:08.084490 | Checking out repos 2026-05-19 14:42:08.137613 | Preparing playbooks 2026-05-19 14:42:09.648652 | Running Ansible setup 2026-05-19 14:42:16.025185 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 14:42:17.664182 | 2026-05-19 14:42:17.664305 | PLAY [Base pre] 2026-05-19 14:42:17.718446 | 2026-05-19 14:42:17.718567 | TASK [Setup log path fact] 2026-05-19 14:42:17.745364 | debian-bookworm | ok 2026-05-19 14:42:17.758163 | 2026-05-19 14:42:17.758275 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 14:42:17.792627 | debian-bookworm | ok 2026-05-19 14:42:17.803630 | 2026-05-19 14:42:17.803729 | TASK [emit-job-header : Print job information] 2026-05-19 14:42:17.851153 | # Job Information 2026-05-19 14:42:17.851335 | Ansible Version: 2.16.14 2026-05-19 14:42:17.851364 | Job: mypy 2026-05-19 14:42:17.851392 | Pipeline: check 2026-05-19 14:42:17.851411 | Executor: 521e9411259a 2026-05-19 14:42:17.851428 | Triggered by: https://github.com/osism/python-osism/pull/2290 2026-05-19 14:42:17.851448 | Event ID: e2c98650-5390-11f1-822e-99bdb0084f5b 2026-05-19 14:42:17.856057 | 2026-05-19 14:42:17.856152 | LOOP [emit-job-header : Print node information] 2026-05-19 14:42:18.079133 | debian-bookworm | ok: 2026-05-19 14:42:18.079329 | debian-bookworm | # Node Information 2026-05-19 14:42:18.079363 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 14:42:18.079388 | debian-bookworm | Hostname: debian 2026-05-19 14:42:18.079408 | debian-bookworm | Username: zuul 2026-05-19 14:42:18.079428 | debian-bookworm | Distro: Debian 12.14 2026-05-19 14:42:18.079451 | debian-bookworm | Provider: regiocloud-a 2026-05-19 14:42:18.079497 | debian-bookworm | Region: 2026-05-19 14:42:18.079521 | debian-bookworm | Label: debian-bookworm 2026-05-19 14:42:18.079541 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 14:42:18.079561 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef2:7db0 2026-05-19 14:42:18.113120 | 2026-05-19 14:42:18.113225 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 14:42:18.790527 | debian-bookworm -> localhost | changed 2026-05-19 14:42:18.796217 | 2026-05-19 14:42:18.796321 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 14:42:20.581499 | debian-bookworm -> localhost | changed 2026-05-19 14:42:20.609293 | 2026-05-19 14:42:20.609435 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 14:42:21.141830 | debian-bookworm -> localhost | ok 2026-05-19 14:42:21.148474 | 2026-05-19 14:42:21.148591 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 14:42:21.187997 | debian-bookworm | ok 2026-05-19 14:42:21.218828 | debian-bookworm | included: /var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 14:42:21.231666 | 2026-05-19 14:42:21.231776 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 14:42:22.892949 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 14:42:22.893131 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/e4adbb3894ec40ea9a51d7c3a9b23cde_id_rsa 2026-05-19 14:42:22.893162 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/e4adbb3894ec40ea9a51d7c3a9b23cde_id_rsa.pub 2026-05-19 14:42:22.893183 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 14:42:22.893202 | debian-bookworm -> localhost | SHA256:6NGjwnxZ5Sc79ZFRBbFoh7GOloBMoGhhpeUe+Scn2uA zuul-build-sshkey 2026-05-19 14:42:22.893220 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 14:42:22.893245 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 14:42:22.893262 | debian-bookworm -> localhost | | o.o... . oo+| 2026-05-19 14:42:22.893280 | debian-bookworm -> localhost | |..=..o . = o | 2026-05-19 14:42:22.893296 | debian-bookworm -> localhost | |.o.+ o . . = + | 2026-05-19 14:42:22.893312 | debian-bookworm -> localhost | |. . o o + = . o | 2026-05-19 14:42:22.893328 | debian-bookworm -> localhost | | o +ooS * + o | 2026-05-19 14:42:22.893349 | debian-bookworm -> localhost | | .o+.== o = . . | 2026-05-19 14:42:22.893366 | debian-bookworm -> localhost | | E+.= o . | 2026-05-19 14:42:22.893382 | debian-bookworm -> localhost | | o . | 2026-05-19 14:42:22.893399 | debian-bookworm -> localhost | | | 2026-05-19 14:42:22.893416 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 14:42:22.893474 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.816634 2026-05-19 14:42:22.898423 | 2026-05-19 14:42:22.898522 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 14:42:22.924889 | debian-bookworm | ok 2026-05-19 14:42:22.932020 | debian-bookworm | included: /var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 14:42:22.960379 | 2026-05-19 14:42:22.960517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 14:42:23.024081 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:42:23.029756 | 2026-05-19 14:42:23.029853 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 14:42:23.789648 | debian-bookworm | changed 2026-05-19 14:42:23.794846 | 2026-05-19 14:42:23.794932 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 14:42:24.065207 | debian-bookworm | ok 2026-05-19 14:42:24.070865 | 2026-05-19 14:42:24.070956 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 14:42:24.767580 | debian-bookworm | changed 2026-05-19 14:42:24.775867 | 2026-05-19 14:42:24.775986 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 14:42:25.425209 | debian-bookworm | changed 2026-05-19 14:42:25.430566 | 2026-05-19 14:42:25.430678 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 14:42:25.443428 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:42:25.449258 | 2026-05-19 14:42:25.449356 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 14:42:25.835987 | debian-bookworm -> localhost | changed 2026-05-19 14:42:25.850977 | 2026-05-19 14:42:25.851096 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 14:42:26.210716 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/e4adbb3894ec40ea9a51d7c3a9b23cde_id_rsa (zuul-build-sshkey) 2026-05-19 14:42:26.210952 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009705 2026-05-19 14:42:26.218360 | 2026-05-19 14:42:26.218472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 14:42:26.725738 | debian-bookworm | ok 2026-05-19 14:42:26.739390 | 2026-05-19 14:42:26.739513 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 14:42:26.772557 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:42:26.782825 | 2026-05-19 14:42:26.782940 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 14:42:27.268519 | debian-bookworm | ok 2026-05-19 14:42:27.294860 | 2026-05-19 14:42:27.294977 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 14:42:27.343972 | debian-bookworm | ok 2026-05-19 14:42:27.348881 | 2026-05-19 14:42:27.348975 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 14:42:27.708101 | debian-bookworm -> localhost | ok 2026-05-19 14:42:27.728916 | 2026-05-19 14:42:27.729024 | TASK [validate-host : Collect information about the host] 2026-05-19 14:42:28.938459 | debian-bookworm | ok 2026-05-19 14:42:28.955557 | 2026-05-19 14:42:28.955702 | TASK [validate-host : Sanitize hostname] 2026-05-19 14:42:29.078566 | debian-bookworm | ok 2026-05-19 14:42:29.128609 | 2026-05-19 14:42:29.128749 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 14:42:30.119957 | debian-bookworm -> localhost | changed 2026-05-19 14:42:30.126047 | 2026-05-19 14:42:30.126175 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 14:42:30.544378 | debian-bookworm | ok 2026-05-19 14:42:30.550992 | 2026-05-19 14:42:30.551097 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 14:42:31.111975 | debian-bookworm -> localhost | changed 2026-05-19 14:42:31.121167 | 2026-05-19 14:42:31.121274 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 14:42:31.389920 | debian-bookworm | ok 2026-05-19 14:42:31.396264 | 2026-05-19 14:42:31.396368 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 14:42:32.720086 | debian-bookworm | changed: 2026-05-19 14:42:32.720336 | debian-bookworm | cd+++++++++ src/ 2026-05-19 14:42:32.720375 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 14:42:32.720399 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 14:42:32.720514 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-19 14:42:32.720538 | debian-bookworm | Containerfile 2026-05-19 14:42:32.720669 | debian-bookworm | Containerfile 2026-05-19 14:42:32.744665 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (48.0.0) 2026-05-19 14:44:03.895071 | 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-19 14:44:03.899380 | 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-19 14:44:04.674559 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-PyYAML, types-pytz, types-python-dateutil, types-PyMySQL, types-paramiko 2026-05-19 14:44:04.942967 | 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-19 14:44:10.223702 | 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-19 14:44:10.223772 | 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-19 14:44:10.223790 | 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-19 14:44:10.223811 | 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-19 14:44:10.223825 | 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-19 14:44:10.223839 | 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-19 14:44:10.223853 | 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-19 14:44:10.223868 | 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-19 14:44:10.223882 | 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-19 14:44:10.223895 | 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-19 14:44:10.223908 | 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-19 14:44:10.223934 | 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-19 14:44:10.223948 | 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-19 14:44:10.223961 | 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-19 14:44:10.224005 | debian-bookworm | Installing missing stub packages: 2026-05-19 14:44:10.224012 | 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-19 14:44:10.224016 | debian-bookworm | 2026-05-19 14:44:10.224020 | debian-bookworm | 2026-05-19 14:44:10.224024 | debian-bookworm | Success: no issues found in 126 source files 2026-05-19 14:44:10.720592 | debian-bookworm | ok: Runtime: 0:00:22.780302 2026-05-19 14:44:10.739147 | 2026-05-19 14:44:10.739273 | PLAY RECAP 2026-05-19 14:44:10.739340 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-05-19 14:44:10.739372 | 2026-05-19 14:44:10.871470 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-19 14:44:10.872440 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 14:44:11.633743 | 2026-05-19 14:44:11.633926 | PLAY [Base post-fetch] 2026-05-19 14:44:11.649825 | 2026-05-19 14:44:11.649992 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-19 14:44:11.706013 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:44:11.717698 | 2026-05-19 14:44:11.717910 | TASK [fetch-output : Set log path for single node] 2026-05-19 14:44:11.765753 | debian-bookworm | ok 2026-05-19 14:44:11.774371 | 2026-05-19 14:44:11.774562 | LOOP [fetch-output : Ensure local output dirs] 2026-05-19 14:44:12.276741 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/logs" 2026-05-19 14:44:12.580499 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/artifacts" 2026-05-19 14:44:12.858464 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e4adbb3894ec40ea9a51d7c3a9b23cde/work/docs" 2026-05-19 14:44:12.885587 | 2026-05-19 14:44:12.885779 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 14:44:13.717012 | debian-bookworm | changed: 2026-05-19 14:44:13.717330 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 14:44:13.717380 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 14:44:13.717433 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 14:44:13.717504 | debian-bookworm | changed: All items complete 2026-05-19 14:44:13.717539 | 2026-05-19 14:44:14.330691 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 14:44:14.894109 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 14:44:14.914898 | 2026-05-19 14:44:14.915054 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 14:44:15.445401 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010080 2026-05-19 14:44:15.771723 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.013824 2026-05-19 14:44:15.790426 | 2026-05-19 14:44:15.790647 | PLAY RECAP 2026-05-19 14:44:15.790717 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-19 14:44:15.790747 | 2026-05-19 14:44:15.939643 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 14:44:15.941763 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 14:44:16.718615 | 2026-05-19 14:44:16.718806 | PLAY [Base post] 2026-05-19 14:44:16.733015 | 2026-05-19 14:44:16.733220 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 14:44:17.332534 | debian-bookworm | changed 2026-05-19 14:44:17.342583 | 2026-05-19 14:44:17.342725 | PLAY RECAP 2026-05-19 14:44:17.342812 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 14:44:17.342914 | 2026-05-19 14:44:17.473469 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 14:44:17.475686 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 14:44:18.292769 | 2026-05-19 14:44:18.292946 | PLAY [Base post-logs] 2026-05-19 14:44:18.304103 | 2026-05-19 14:44:18.304276 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 14:44:18.838540 | localhost | changed 2026-05-19 14:44:18.849778 | 2026-05-19 14:44:18.849976 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 14:44:18.886314 | localhost | ok 2026-05-19 14:44:18.890087 | 2026-05-19 14:44:18.890228 | TASK [Set zuul-log-path fact] 2026-05-19 14:44:18.905678 | localhost | ok 2026-05-19 14:44:18.917075 | 2026-05-19 14:44:18.917378 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 14:44:18.948294 | localhost | ok 2026-05-19 14:44:18.955602 | 2026-05-19 14:44:18.955781 | TASK [upload-logs : Create log directories] 2026-05-19 14:44:19.459665 | localhost | changed 2026-05-19 14:44:19.465667 | 2026-05-19 14:44:19.465844 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 14:44:19.989521 | localhost -> localhost | ok: Runtime: 0:00:00.007105 2026-05-19 14:44:19.993809 | 2026-05-19 14:44:19.993928 | TASK [upload-logs : Upload logs to log server] 2026-05-19 14:44:20.582330 | localhost | Output suppressed because no_log was given 2026-05-19 14:44:20.584477 | 2026-05-19 14:44:20.584592 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 14:44:20.637845 | localhost | skipping: Conditional result was False 2026-05-19 14:44:20.642328 | localhost | skipping: Conditional result was False 2026-05-19 14:44:20.654623 | 2026-05-19 14:44:20.654784 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 14:44:20.702120 | localhost | skipping: Conditional result was False 2026-05-19 14:44:20.702821 | 2026-05-19 14:44:20.706113 | localhost | skipping: Conditional result was False 2026-05-19 14:44:20.716481 | 2026-05-19 14:44:20.716600 | LOOP [upload-logs : Upload console log and json output]