2026-05-18 12:28:18.550978 | Job console starting 2026-05-18 12:28:18.565788 | Updating git repos 2026-05-18 12:28:18.615031 | Cloning repos into workspace 2026-05-18 12:28:18.678795 | Restoring repo states 2026-05-18 12:28:18.695051 | Merging changes 2026-05-18 12:28:19.415499 | Checking out repos 2026-05-18 12:28:19.534066 | Preparing playbooks 2026-05-18 12:28:20.714455 | Running Ansible setup 2026-05-18 12:28:26.530318 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 12:28:27.898187 | 2026-05-18 12:28:27.898399 | PLAY [Base pre] 2026-05-18 12:28:27.934594 | 2026-05-18 12:28:27.934764 | TASK [Setup log path fact] 2026-05-18 12:28:27.964983 | debian-bookworm | ok 2026-05-18 12:28:27.997826 | 2026-05-18 12:28:27.998096 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 12:28:28.037506 | debian-bookworm | ok 2026-05-18 12:28:28.048533 | 2026-05-18 12:28:28.048680 | TASK [emit-job-header : Print job information] 2026-05-18 12:28:28.107834 | # Job Information 2026-05-18 12:28:28.108039 | Ansible Version: 2.16.14 2026-05-18 12:28:28.108076 | Job: mypy 2026-05-18 12:28:28.108111 | Pipeline: check 2026-05-18 12:28:28.108134 | Executor: 521e9411259a 2026-05-18 12:28:28.108156 | Triggered by: https://github.com/osism/python-osism/pull/2274 2026-05-18 12:28:28.108179 | Event ID: 91754a50-52b4-11f1-9769-a90cc2e2215e 2026-05-18 12:28:28.116222 | 2026-05-18 12:28:28.116573 | LOOP [emit-job-header : Print node information] 2026-05-18 12:28:28.250054 | debian-bookworm | ok: 2026-05-18 12:28:28.250453 | debian-bookworm | # Node Information 2026-05-18 12:28:28.250509 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 12:28:28.250535 | debian-bookworm | Hostname: debian 2026-05-18 12:28:28.250569 | debian-bookworm | Username: zuul 2026-05-18 12:28:28.250590 | debian-bookworm | Distro: Debian 12.14 2026-05-18 12:28:28.250614 | debian-bookworm | Provider: regiocloud-a 2026-05-18 12:28:28.250635 | debian-bookworm | Region: 2026-05-18 12:28:28.250656 | debian-bookworm | Label: debian-bookworm 2026-05-18 12:28:28.250676 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 12:28:28.250697 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:a3ac 2026-05-18 12:28:28.279521 | 2026-05-18 12:28:28.279683 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 12:28:28.938105 | debian-bookworm -> localhost | changed 2026-05-18 12:28:28.951440 | 2026-05-18 12:28:28.951622 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 12:28:31.759460 | debian-bookworm -> localhost | changed 2026-05-18 12:28:31.802757 | 2026-05-18 12:28:31.802951 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 12:28:32.727353 | debian-bookworm -> localhost | ok 2026-05-18 12:28:32.734217 | 2026-05-18 12:28:32.734372 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 12:28:32.805808 | debian-bookworm | ok 2026-05-18 12:28:32.841097 | debian-bookworm | included: /var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 12:28:32.848416 | 2026-05-18 12:28:32.848593 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 12:28:36.476707 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 12:28:36.476913 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/dd014308849e4ab19f82dfaf8dea10ac_id_rsa 2026-05-18 12:28:36.476950 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/dd014308849e4ab19f82dfaf8dea10ac_id_rsa.pub 2026-05-18 12:28:36.476977 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 12:28:36.477000 | debian-bookworm -> localhost | SHA256:yJAta0EXyZxMiG7UtSxehq2Phg+jYdWBs+vtzGryybo zuul-build-sshkey 2026-05-18 12:28:36.477022 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 12:28:36.477056 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 12:28:36.477079 | debian-bookworm -> localhost | | o.B=+ | 2026-05-18 12:28:36.477101 | debian-bookworm -> localhost | | o.+B*. | 2026-05-18 12:28:36.477121 | debian-bookworm -> localhost | | o oB.B | 2026-05-18 12:28:36.477141 | debian-bookworm -> localhost | | o.+@.. | 2026-05-18 12:28:36.477162 | debian-bookworm -> localhost | | . o=.o S | 2026-05-18 12:28:36.477188 | debian-bookworm -> localhost | | .o.o | 2026-05-18 12:28:36.477209 | debian-bookworm -> localhost | |..+.o . | 2026-05-18 12:28:36.477231 | debian-bookworm -> localhost | |.+o*= | 2026-05-18 12:28:36.477252 | debian-bookworm -> localhost | |.E**+= | 2026-05-18 12:28:36.477271 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 12:28:36.477333 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.434795 2026-05-18 12:28:36.484377 | 2026-05-18 12:28:36.484470 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 12:28:36.512685 | debian-bookworm | ok 2026-05-18 12:28:36.521741 | debian-bookworm | included: /var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 12:28:36.530710 | 2026-05-18 12:28:36.530797 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 12:28:36.560201 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:28:36.567844 | 2026-05-18 12:28:36.567941 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 12:28:37.264465 | debian-bookworm | changed 2026-05-18 12:28:37.270347 | 2026-05-18 12:28:37.270436 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 12:28:37.558538 | debian-bookworm | ok 2026-05-18 12:28:37.566105 | 2026-05-18 12:28:37.566203 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 12:28:38.421029 | debian-bookworm | changed 2026-05-18 12:28:38.435047 | 2026-05-18 12:28:38.435154 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 12:28:39.267551 | debian-bookworm | changed 2026-05-18 12:28:39.273434 | 2026-05-18 12:28:39.273532 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 12:28:39.297271 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:28:39.303697 | 2026-05-18 12:28:39.303793 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 12:28:39.896432 | debian-bookworm -> localhost | changed 2026-05-18 12:28:39.914973 | 2026-05-18 12:28:39.915087 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 12:28:40.540387 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/dd014308849e4ab19f82dfaf8dea10ac_id_rsa (zuul-build-sshkey) 2026-05-18 12:28:40.540606 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028792 2026-05-18 12:28:40.548974 | 2026-05-18 12:28:40.549067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 12:28:41.227579 | debian-bookworm | ok 2026-05-18 12:28:41.232873 | 2026-05-18 12:28:41.232976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 12:28:41.280679 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:28:41.298569 | 2026-05-18 12:28:41.298681 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 12:28:41.848018 | debian-bookworm | ok 2026-05-18 12:28:41.869464 | 2026-05-18 12:28:41.869611 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 12:28:41.934822 | debian-bookworm | ok 2026-05-18 12:28:41.945584 | 2026-05-18 12:28:41.946074 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 12:28:42.425536 | debian-bookworm -> localhost | ok 2026-05-18 12:28:42.436624 | 2026-05-18 12:28:42.438596 | TASK [validate-host : Collect information about the host] 2026-05-18 12:28:43.883836 | debian-bookworm | ok 2026-05-18 12:28:43.908083 | 2026-05-18 12:28:43.908248 | TASK [validate-host : Sanitize hostname] 2026-05-18 12:28:44.088101 | debian-bookworm | ok 2026-05-18 12:28:44.212953 | 2026-05-18 12:28:44.213109 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 12:28:44.956211 | debian-bookworm -> localhost | changed 2026-05-18 12:28:44.962973 | 2026-05-18 12:28:44.963096 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 12:28:45.454452 | debian-bookworm | ok 2026-05-18 12:28:45.462546 | 2026-05-18 12:28:45.462815 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 12:28:46.279737 | debian-bookworm -> localhost | changed 2026-05-18 12:28:46.290672 | 2026-05-18 12:28:46.290813 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 12:28:46.683655 | debian-bookworm | ok 2026-05-18 12:28:46.730268 | 2026-05-18 12:28:46.730460 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 12:28:48.651566 | debian-bookworm | changed: 2026-05-18 12:28:48.651876 | debian-bookworm | cd+++++++++ src/ 2026-05-18 12:28:48.651916 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 12:28:48.651940 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 12:28:48.651961 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-18 12:28:48.651981 | debian-bookworm | Containerfile 2026-05-18 12:28:48.652112 | debian-bookworm | Containerfile 2026-05-18 12:28:48.663373 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (48.0.0) 2026-05-18 12:30:18.791983 | 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-18 12:30:18.796472 | 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-18 12:30:19.577409 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-PyYAML, types-pytz, types-python-dateutil, types-PyMySQL, types-paramiko 2026-05-18 12:30:19.794223 | 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-18 12:30:25.603144 | 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-18 12:30:25.603300 | 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-18 12:30:25.603322 | 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-18 12:30:25.603349 | 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-18 12:30:25.603360 | 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-18 12:30:25.603372 | 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-18 12:30:25.603382 | 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-18 12:30:25.603394 | 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-18 12:30:25.603405 | 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-18 12:30:25.603416 | 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-18 12:30:25.603427 | 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-18 12:30:25.603466 | 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-18 12:30:25.603497 | 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-18 12:30:25.603509 | 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-18 12:30:25.603540 | debian-bookworm | Installing missing stub packages: 2026-05-18 12:30:25.603554 | 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-18 12:30:25.603566 | debian-bookworm | 2026-05-18 12:30:25.603577 | debian-bookworm | 2026-05-18 12:30:25.603588 | debian-bookworm | Success: no issues found in 122 source files 2026-05-18 12:30:26.014056 | debian-bookworm | ok: Runtime: 0:00:21.382875 2026-05-18 12:30:26.027869 | 2026-05-18 12:30:26.030857 | PLAY RECAP 2026-05-18 12:30:26.030944 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-05-18 12:30:26.030972 | 2026-05-18 12:30:26.265329 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-18 12:30:26.266240 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 12:30:27.220597 | 2026-05-18 12:30:27.220740 | PLAY [Base post-fetch] 2026-05-18 12:30:27.234550 | 2026-05-18 12:30:27.234677 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-18 12:30:27.279018 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:30:27.285496 | 2026-05-18 12:30:27.285633 | TASK [fetch-output : Set log path for single node] 2026-05-18 12:30:27.326940 | debian-bookworm | ok 2026-05-18 12:30:27.332099 | 2026-05-18 12:30:27.332200 | LOOP [fetch-output : Ensure local output dirs] 2026-05-18 12:30:28.116469 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/logs" 2026-05-18 12:30:28.442202 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/artifacts" 2026-05-18 12:30:28.697358 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dd014308849e4ab19f82dfaf8dea10ac/work/docs" 2026-05-18 12:30:28.712207 | 2026-05-18 12:30:28.712349 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 12:30:29.505155 | debian-bookworm | changed: 2026-05-18 12:30:29.505395 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 12:30:29.505432 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 12:30:29.505462 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 12:30:29.505504 | debian-bookworm | changed: All items complete 2026-05-18 12:30:29.505528 | 2026-05-18 12:30:30.142813 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 12:30:30.832818 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 12:30:30.846995 | 2026-05-18 12:30:30.847111 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 12:30:31.651343 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.018162 2026-05-18 12:30:32.050267 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.005921 2026-05-18 12:30:32.064934 | 2026-05-18 12:30:32.065024 | PLAY RECAP 2026-05-18 12:30:32.065075 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 12:30:32.065100 | 2026-05-18 12:30:32.232627 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 12:30:32.233619 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 12:30:33.439482 | 2026-05-18 12:30:33.439682 | PLAY [Base post] 2026-05-18 12:30:33.454347 | 2026-05-18 12:30:33.454522 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 12:30:34.339858 | debian-bookworm | changed 2026-05-18 12:30:34.350524 | 2026-05-18 12:30:34.350667 | PLAY RECAP 2026-05-18 12:30:34.350740 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 12:30:34.350809 | 2026-05-18 12:30:34.495140 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 12:30:34.496503 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 12:30:35.668390 | 2026-05-18 12:30:35.668574 | PLAY [Base post-logs] 2026-05-18 12:30:35.679526 | 2026-05-18 12:30:35.679671 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 12:30:36.217939 | localhost | changed 2026-05-18 12:30:36.228843 | 2026-05-18 12:30:36.229024 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 12:30:36.265765 | localhost | ok 2026-05-18 12:30:36.269913 | 2026-05-18 12:30:36.270046 | TASK [Set zuul-log-path fact] 2026-05-18 12:30:36.286129 | localhost | ok 2026-05-18 12:30:36.295983 | 2026-05-18 12:30:36.296136 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 12:30:36.321787 | localhost | ok 2026-05-18 12:30:36.325424 | 2026-05-18 12:30:36.325555 | TASK [upload-logs : Create log directories] 2026-05-18 12:30:36.887768 | localhost | changed 2026-05-18 12:30:36.890697 | 2026-05-18 12:30:36.890895 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 12:30:37.569817 | localhost -> localhost | ok: Runtime: 0:00:00.010615 2026-05-18 12:30:37.574138 | 2026-05-18 12:30:37.574286 | TASK [upload-logs : Upload logs to log server] 2026-05-18 12:30:38.266569 | localhost | Output suppressed because no_log was given 2026-05-18 12:30:38.272622 | 2026-05-18 12:30:38.272747 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 12:30:38.349092 | localhost | skipping: Conditional result was False 2026-05-18 12:30:38.363595 | localhost | skipping: Conditional result was False 2026-05-18 12:30:38.373011 | 2026-05-18 12:30:38.373150 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 12:30:38.424665 | localhost | skipping: Conditional result was False 2026-05-18 12:30:38.425017 | 2026-05-18 12:30:38.432126 | localhost | skipping: Conditional result was False 2026-05-18 12:30:38.441638 | 2026-05-18 12:30:38.441759 | LOOP [upload-logs : Upload console log and json output]