2025-08-23 09:53:53.805591 | Job console starting 2025-08-23 09:53:53.813559 | Updating git repos 2025-08-23 09:53:53.843615 | Cloning repos into workspace 2025-08-23 09:53:53.935350 | Restoring repo states 2025-08-23 09:53:53.941091 | Merging changes 2025-08-23 09:53:54.509419 | Checking out repos 2025-08-23 09:53:54.541625 | Preparing playbooks 2025-08-23 09:53:55.081513 | Running Ansible setup 2025-08-23 09:54:00.588859 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 09:54:02.069098 | 2025-08-23 09:54:02.069229 | PLAY [Base pre] 2025-08-23 09:54:02.089590 | 2025-08-23 09:54:02.089709 | TASK [Setup log path fact] 2025-08-23 09:54:02.121298 | debian-bookworm | ok 2025-08-23 09:54:02.136427 | 2025-08-23 09:54:02.136551 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:54:02.165401 | debian-bookworm | ok 2025-08-23 09:54:02.176230 | 2025-08-23 09:54:02.176332 | TASK [emit-job-header : Print job information] 2025-08-23 09:54:02.237548 | # Job Information 2025-08-23 09:54:02.237706 | Ansible Version: 2.16.14 2025-08-23 09:54:02.237742 | Job: mypy 2025-08-23 09:54:02.237775 | Pipeline: check 2025-08-23 09:54:02.237824 | Executor: 521e9411259a 2025-08-23 09:54:02.237847 | Triggered by: https://github.com/osism/python-osism/pull/1656 2025-08-23 09:54:02.237870 | Event ID: 0728b4c0-8007-11f0-8adf-79aa1e588a42 2025-08-23 09:54:02.248434 | 2025-08-23 09:54:02.248555 | LOOP [emit-job-header : Print node information] 2025-08-23 09:54:02.388965 | debian-bookworm | ok: 2025-08-23 09:54:02.389258 | debian-bookworm | # Node Information 2025-08-23 09:54:02.389298 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 09:54:02.389324 | debian-bookworm | Hostname: debian 2025-08-23 09:54:02.389346 | debian-bookworm | Username: zuul 2025-08-23 09:54:02.389367 | debian-bookworm | Distro: Debian 12.11 2025-08-23 09:54:02.389390 | debian-bookworm | Provider: regiocloud-a 2025-08-23 09:54:02.389412 | debian-bookworm | Region: 2025-08-23 09:54:02.389433 | debian-bookworm | Label: debian-bookworm 2025-08-23 09:54:02.389454 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 09:54:02.389474 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:7a0a 2025-08-23 09:54:02.404123 | 2025-08-23 09:54:02.404230 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 09:54:03.473984 | debian-bookworm -> localhost | changed 2025-08-23 09:54:03.480780 | 2025-08-23 09:54:03.480900 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 09:54:05.220771 | debian-bookworm -> localhost | changed 2025-08-23 09:54:05.229721 | 2025-08-23 09:54:05.229840 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 09:54:05.711971 | debian-bookworm -> localhost | ok 2025-08-23 09:54:05.717992 | 2025-08-23 09:54:05.718089 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 09:54:05.745943 | debian-bookworm | ok 2025-08-23 09:54:05.771776 | debian-bookworm | included: /var/lib/zuul/builds/f81b7f376c2d49c684dab5f4491f6d27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 09:54:05.777075 | 2025-08-23 09:54:05.777156 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 09:54:07.671300 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 09:54:07.671463 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f81b7f376c2d49c684dab5f4491f6d27/work/f81b7f376c2d49c684dab5f4491f6d27_id_rsa 2025-08-23 09:54:07.671495 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f81b7f376c2d49c684dab5f4491f6d27/work/f81b7f376c2d49c684dab5f4491f6d27_id_rsa.pub 2025-08-23 09:54:07.671517 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 09:54:07.671539 | debian-bookworm -> localhost | SHA256:CgsxskKqCEMRib/fWrctvHSqSGkcNiM67tTEFoTPHJU zuul-build-sshkey 2025-08-23 09:54:07.671558 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 09:54:07.671584 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 09:54:07.671603 | debian-bookworm -> localhost | |.o+.... | 2025-08-23 09:54:07.671621 | debian-bookworm -> localhost | |.oo. E | 2025-08-23 09:54:07.671639 | debian-bookworm -> localhost | |.+*.. | 2025-08-23 09:54:07.671655 | debian-bookworm -> localhost | |+oo*. | 2025-08-23 09:54:07.671673 | debian-bookworm -> localhost | |* o=* S | 2025-08-23 09:54:07.671695 | debian-bookworm -> localhost | |=o== B . | 2025-08-23 09:54:07.671713 | debian-bookworm -> localhost | |=. o*.o.o . | 2025-08-23 09:54:07.671730 | debian-bookworm -> localhost | |o. o.o.oo= | 2025-08-23 09:54:07.671748 | debian-bookworm -> localhost | |.o o...+o. | 2025-08-23 09:54:07.671765 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 09:54:07.671822 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.834738 2025-08-23 09:54:07.677342 | 2025-08-23 09:54:07.677418 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 09:54:07.693510 | debian-bookworm | ok 2025-08-23 09:54:07.701918 | debian-bookworm | included: /var/lib/zuul/builds/f81b7f376c2d49c684dab5f4491f6d27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 09:54:07.709313 | 2025-08-23 09:54:07.709385 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 09:54:07.731822 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:07.736541 | 2025-08-23 09:54:07.736620 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 09:54:08.491891 | debian-bookworm | changed 2025-08-23 09:54:08.502025 | 2025-08-23 09:54:08.502335 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 09:54:08.761408 | debian-bookworm | ok 2025-08-23 09:54:08.769208 | 2025-08-23 09:54:08.769312 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 09:54:09.450558 | debian-bookworm | changed 2025-08-23 09:54:09.456947 | 2025-08-23 09:54:09.457033 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 09:54:10.082656 | debian-bookworm | changed 2025-08-23 09:54:10.087834 | 2025-08-23 09:54:10.087924 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 09:54:10.110557 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:10.119963 | 2025-08-23 09:54:10.120056 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 09:54:10.526307 | debian-bookworm -> localhost | changed 2025-08-23 09:54:10.536561 | 2025-08-23 09:54:10.536661 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 09:54:10.842294 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f81b7f376c2d49c684dab5f4491f6d27/work/f81b7f376c2d49c684dab5f4491f6d27_id_rsa (zuul-build-sshkey) 2025-08-23 09:54:10.842510 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017770 2025-08-23 09:54:10.850053 | 2025-08-23 09:54:10.850152 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 09:54:11.270881 | debian-bookworm | ok 2025-08-23 09:54:11.275776 | 2025-08-23 09:54:11.275888 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 09:54:11.303280 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:11.313315 | 2025-08-23 09:54:11.313412 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 09:54:11.746991 | debian-bookworm | ok 2025-08-23 09:54:11.763378 | 2025-08-23 09:54:11.763489 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 09:54:11.791245 | debian-bookworm | ok 2025-08-23 09:54:11.796223 | 2025-08-23 09:54:11.796327 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 09:54:12.062062 | debian-bookworm -> localhost | ok 2025-08-23 09:54:12.068311 | 2025-08-23 09:54:12.068403 | TASK [validate-host : Collect information about the host] 2025-08-23 09:54:13.170696 | debian-bookworm | ok 2025-08-23 09:54:13.190186 | 2025-08-23 09:54:13.190541 | TASK [validate-host : Sanitize hostname] 2025-08-23 09:54:13.294049 | debian-bookworm | ok 2025-08-23 09:54:13.338229 | 2025-08-23 09:54:13.338326 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 09:54:13.897436 | debian-bookworm -> localhost | changed 2025-08-23 09:54:13.903466 | 2025-08-23 09:54:13.903584 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 09:54:14.328671 | debian-bookworm | ok 2025-08-23 09:54:14.337007 | 2025-08-23 09:54:14.337140 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 09:54:14.999843 | debian-bookworm -> localhost | changed 2025-08-23 09:54:15.017749 | 2025-08-23 09:54:15.017948 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 09:54:15.302737 | debian-bookworm | ok 2025-08-23 09:54:15.310102 | 2025-08-23 09:54:15.310269 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 09:54:16.606410 | debian-bookworm | changed: 2025-08-23 09:54:16.606614 | debian-bookworm | cd+++++++++ src/ 2025-08-23 09:54:16.606650 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 09:54:16.606674 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 09:54:16.606696 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 09:54:16.606717 | debian-bookworm | Containerfile 2025-08-23 09:54:16.606892 | debian-bookworm | Containerfile 2025-08-23 09:54:16.638690 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (45.0.6) 2025-08-23 09:55:35.554036 | debian-bookworm | Collecting types-cffi 2025-08-23 09:55:35.563008 | debian-bookworm | Downloading types_cffi-1.17.0.20250822-py3-none-any.whl (20 kB) 2025-08-23 09:55:35.575743 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.5.0) 2025-08-23 09:55:35.603484 | debian-bookworm | Requirement already satisfied: cffi>=1.14 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=37.0.0->types-paramiko) (1.17.1) 2025-08-23 09:55:35.682205 | debian-bookworm | Collecting types-setuptools 2025-08-23 09:55:35.691833 | debian-bookworm | Downloading types_setuptools-80.9.0.20250822-py3-none-any.whl (63 kB) 2025-08-23 09:55:35.699324 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.2/63.2 kB 12.6 MB/s eta 0:00:00 2025-08-23 09:55:35.704731 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=1.14->cryptography>=37.0.0->types-paramiko) (2.22) 2025-08-23 09:55:36.453839 | 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, types-paramiko 2025-08-23 09:55:36.850231 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20250822 types-cffi-1.17.0.20250822 types-decorator-5.2.0.20250324 types-paramiko-4.0.0.20250822 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20250822 types-pytz-2025.2.0.20250809 types-requests-2.32.4.20250809 types-setuptools-80.9.0.20250822 types-simplejson-3.20.0.20250822 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250822 2025-08-23 09:55:44.275373 | 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] 2025-08-23 09:55:44.275538 | 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-08-23 09:55:44.275563 | 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-08-23 09:55:44.275578 | debian-bookworm | Installing missing stub packages: 2025-08-23 09:55:44.275591 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-paramiko types-pyOpenSSL types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-08-23 09:55:44.275633 | debian-bookworm | 2025-08-23 09:55:44.275645 | debian-bookworm | 2025-08-23 09:55:44.275657 | debian-bookworm | Success: no issues found in 65 source files 2025-08-23 09:55:44.677381 | debian-bookworm | ok: Runtime: 0:00:24.889245 2025-08-23 09:55:44.685766 | 2025-08-23 09:55:44.685833 | PLAY RECAP 2025-08-23 09:55:44.685882 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-08-23 09:55:44.685908 | 2025-08-23 09:55:44.832596 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-08-23 09:55:44.833385 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-23 09:55:45.637805 | 2025-08-23 09:55:45.637965 | PLAY [Base post] 2025-08-23 09:55:45.652284 | 2025-08-23 09:55:45.652420 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-23 09:55:46.285036 | debian-bookworm | changed 2025-08-23 09:55:46.292243 | 2025-08-23 09:55:46.292365 | PLAY RECAP 2025-08-23 09:55:46.292430 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-23 09:55:46.292492 | 2025-08-23 09:55:46.430345 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-23 09:55:46.431300 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-23 09:55:47.291710 | 2025-08-23 09:55:47.291907 | PLAY [Base post-logs] 2025-08-23 09:55:47.302656 | 2025-08-23 09:55:47.302826 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-23 09:55:47.788165 | localhost | changed 2025-08-23 09:55:47.807194 | 2025-08-23 09:55:47.807391 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-23 09:55:47.837430 | localhost | ok 2025-08-23 09:55:47.841228 | 2025-08-23 09:55:47.841329 | TASK [Set zuul-log-path fact] 2025-08-23 09:55:47.856435 | localhost | ok 2025-08-23 09:55:47.866528 | 2025-08-23 09:55:47.866651 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:55:47.893257 | localhost | ok 2025-08-23 09:55:47.896726 | 2025-08-23 09:55:47.896886 | TASK [upload-logs : Create log directories] 2025-08-23 09:55:48.416517 | localhost | changed 2025-08-23 09:55:48.419386 | 2025-08-23 09:55:48.419497 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-23 09:55:48.917473 | localhost -> localhost | ok: Runtime: 0:00:00.008862 2025-08-23 09:55:48.925510 | 2025-08-23 09:55:48.925643 | TASK [upload-logs : Upload logs to log server] 2025-08-23 09:55:49.529634 | localhost | Output suppressed because no_log was given 2025-08-23 09:55:49.531702 | 2025-08-23 09:55:49.531863 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 09:55:49.579532 | localhost | skipping: Conditional result was False 2025-08-23 09:55:49.585658 | localhost | skipping: Conditional result was False 2025-08-23 09:55:49.588922 | 2025-08-23 09:55:49.589032 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 09:55:49.651577 | localhost | skipping: Conditional result was False 2025-08-23 09:55:49.651907 | 2025-08-23 09:55:49.658219 | localhost | skipping: Conditional result was False 2025-08-23 09:55:49.661673 | 2025-08-23 09:55:49.661805 | LOOP [upload-logs : Upload console log and json output]