2025-08-22 10:59:52.291747 | Job console starting 2025-08-22 10:59:52.311337 | Updating git repos 2025-08-22 10:59:52.348838 | Cloning repos into workspace 2025-08-22 10:59:52.417705 | Restoring repo states 2025-08-22 10:59:52.425990 | Merging changes 2025-08-22 10:59:53.030065 | Checking out repos 2025-08-22 10:59:53.122461 | Preparing playbooks 2025-08-22 10:59:54.142000 | Running Ansible setup 2025-08-22 10:59:59.683849 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-22 11:00:00.828374 | 2025-08-22 11:00:00.828553 | PLAY [Base pre] 2025-08-22 11:00:00.853534 | 2025-08-22 11:00:00.853711 | TASK [Setup log path fact] 2025-08-22 11:00:00.884737 | debian-bookworm | ok 2025-08-22 11:00:00.900783 | 2025-08-22 11:00:00.900951 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-22 11:00:00.932734 | debian-bookworm | ok 2025-08-22 11:00:00.944042 | 2025-08-22 11:00:00.944183 | TASK [emit-job-header : Print job information] 2025-08-22 11:00:00.984834 | # Job Information 2025-08-22 11:00:00.985041 | Ansible Version: 2.16.14 2025-08-22 11:00:00.985077 | Job: mypy 2025-08-22 11:00:00.985109 | Pipeline: check 2025-08-22 11:00:00.985132 | Executor: 521e9411259a 2025-08-22 11:00:00.985153 | Triggered by: https://github.com/osism/python-osism/pull/1653 2025-08-22 11:00:00.985174 | Event ID: 1c0f5da0-7f47-11f0-9ce9-ac419293f09b 2025-08-22 11:00:00.990319 | 2025-08-22 11:00:00.990444 | LOOP [emit-job-header : Print node information] 2025-08-22 11:00:01.105991 | debian-bookworm | ok: 2025-08-22 11:00:01.106194 | debian-bookworm | # Node Information 2025-08-22 11:00:01.106228 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-22 11:00:01.106254 | debian-bookworm | Hostname: debian 2025-08-22 11:00:01.106276 | debian-bookworm | Username: zuul 2025-08-22 11:00:01.106296 | debian-bookworm | Distro: Debian 12.11 2025-08-22 11:00:01.106321 | debian-bookworm | Provider: regiocloud-a 2025-08-22 11:00:01.106341 | debian-bookworm | Region: 2025-08-22 11:00:01.106362 | debian-bookworm | Label: debian-bookworm 2025-08-22 11:00:01.106381 | debian-bookworm | Product Name: OpenStack Nova 2025-08-22 11:00:01.106400 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe08:c8bd 2025-08-22 11:00:01.119225 | 2025-08-22 11:00:01.119372 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-22 11:00:02.279498 | debian-bookworm -> localhost | changed 2025-08-22 11:00:02.286959 | 2025-08-22 11:00:02.287131 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-22 11:00:04.207222 | debian-bookworm -> localhost | changed 2025-08-22 11:00:04.217751 | 2025-08-22 11:00:04.217852 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-22 11:00:04.554116 | debian-bookworm -> localhost | ok 2025-08-22 11:00:04.560026 | 2025-08-22 11:00:04.560135 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-22 11:00:04.589326 | debian-bookworm | ok 2025-08-22 11:00:04.635823 | debian-bookworm | included: /var/lib/zuul/builds/d2893d7145984b9b824cbee26d487884/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-22 11:00:04.653607 | 2025-08-22 11:00:04.653729 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-22 11:00:07.735518 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-22 11:00:07.735720 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d2893d7145984b9b824cbee26d487884/work/d2893d7145984b9b824cbee26d487884_id_rsa 2025-08-22 11:00:07.735760 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d2893d7145984b9b824cbee26d487884/work/d2893d7145984b9b824cbee26d487884_id_rsa.pub 2025-08-22 11:00:07.735787 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-22 11:00:07.735811 | debian-bookworm -> localhost | SHA256:knsW70hiwhR3aFOEDuK7QCJnGp/9xtibTQiPan+nthw zuul-build-sshkey 2025-08-22 11:00:07.735833 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-22 11:00:07.735862 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-22 11:00:07.735885 | debian-bookworm -> localhost | | oo | 2025-08-22 11:00:07.735907 | debian-bookworm -> localhost | | . . .o | 2025-08-22 11:00:07.735928 | debian-bookworm -> localhost | | . ..o= . | 2025-08-22 11:00:07.735948 | debian-bookworm -> localhost | |+.+ +.+ | 2025-08-22 11:00:07.735967 | debian-bookworm -> localhost | |+* +o o S | 2025-08-22 11:00:07.735995 | debian-bookworm -> localhost | |o +o.+ + o | 2025-08-22 11:00:07.736042 | debian-bookworm -> localhost | | . .+=E = . | 2025-08-22 11:00:07.736067 | debian-bookworm -> localhost | | o..+BX.o | 2025-08-22 11:00:07.736089 | debian-bookworm -> localhost | | ....+*=o . | 2025-08-22 11:00:07.736111 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-22 11:00:07.736163 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.096612 2025-08-22 11:00:07.745863 | 2025-08-22 11:00:07.746267 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-22 11:00:07.776843 | debian-bookworm | ok 2025-08-22 11:00:07.785224 | debian-bookworm | included: /var/lib/zuul/builds/d2893d7145984b9b824cbee26d487884/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-22 11:00:07.792837 | 2025-08-22 11:00:07.792923 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-22 11:00:07.806342 | debian-bookworm | skipping: Conditional result was False 2025-08-22 11:00:07.811572 | 2025-08-22 11:00:07.811664 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-22 11:00:08.395766 | debian-bookworm | changed 2025-08-22 11:00:08.403594 | 2025-08-22 11:00:08.403692 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-22 11:00:08.665324 | debian-bookworm | ok 2025-08-22 11:00:08.670793 | 2025-08-22 11:00:08.670897 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-22 11:00:09.301079 | debian-bookworm | changed 2025-08-22 11:00:09.313242 | 2025-08-22 11:00:09.313341 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-22 11:00:09.949815 | debian-bookworm | changed 2025-08-22 11:00:09.960122 | 2025-08-22 11:00:09.960230 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-22 11:00:09.993894 | debian-bookworm | skipping: Conditional result was False 2025-08-22 11:00:10.000531 | 2025-08-22 11:00:10.000668 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-22 11:00:10.670700 | debian-bookworm -> localhost | changed 2025-08-22 11:00:10.681757 | 2025-08-22 11:00:10.681864 | TASK [add-build-sshkey : Add back temp key] 2025-08-22 11:00:11.030308 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d2893d7145984b9b824cbee26d487884/work/d2893d7145984b9b824cbee26d487884_id_rsa (zuul-build-sshkey) 2025-08-22 11:00:11.030549 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013050 2025-08-22 11:00:11.038054 | 2025-08-22 11:00:11.038156 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-22 11:00:11.502337 | debian-bookworm | ok 2025-08-22 11:00:11.507864 | 2025-08-22 11:00:11.507961 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-22 11:00:11.543238 | debian-bookworm | skipping: Conditional result was False 2025-08-22 11:00:11.556796 | 2025-08-22 11:00:11.556904 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-22 11:00:12.052048 | debian-bookworm | ok 2025-08-22 11:00:12.068965 | 2025-08-22 11:00:12.069121 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-22 11:00:12.129341 | debian-bookworm | ok 2025-08-22 11:00:12.134664 | 2025-08-22 11:00:12.134765 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-22 11:00:12.439974 | debian-bookworm -> localhost | ok 2025-08-22 11:00:12.446131 | 2025-08-22 11:00:12.446225 | TASK [validate-host : Collect information about the host] 2025-08-22 11:00:13.613573 | debian-bookworm | ok 2025-08-22 11:00:13.631173 | 2025-08-22 11:00:13.631282 | TASK [validate-host : Sanitize hostname] 2025-08-22 11:00:13.729892 | debian-bookworm | ok 2025-08-22 11:00:13.760283 | 2025-08-22 11:00:13.760556 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-22 11:00:14.383119 | debian-bookworm -> localhost | changed 2025-08-22 11:00:14.391084 | 2025-08-22 11:00:14.391207 | TASK [validate-host : Collect information about zuul worker] 2025-08-22 11:00:14.843088 | debian-bookworm | ok 2025-08-22 11:00:14.847916 | 2025-08-22 11:00:14.848075 | TASK [validate-host : Write out all zuul information for each host] 2025-08-22 11:00:15.500532 | debian-bookworm -> localhost | changed 2025-08-22 11:00:15.507991 | 2025-08-22 11:00:15.508085 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-22 11:00:15.783509 | debian-bookworm | ok 2025-08-22 11:00:15.788759 | 2025-08-22 11:00:15.788852 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-22 11:00:16.944474 | debian-bookworm | changed: 2025-08-22 11:00:16.944637 | debian-bookworm | cd+++++++++ src/ 2025-08-22 11:00:16.944670 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-22 11:00:16.944693 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-22 11:00:16.944713 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-22 11:00:16.944732 | debian-bookworm | Containerfile 2025-08-22 11:00:16.944843 | debian-bookworm | Containerfile 2025-08-22 11:00:17.004298 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (45.0.6) 2025-08-22 11:01:34.998784 | debian-bookworm | Collecting types-cffi 2025-08-22 11:01:35.009105 | debian-bookworm | Downloading types_cffi-1.17.0.20250822-py3-none-any.whl (20 kB) 2025-08-22 11:01:35.046186 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.5.0) 2025-08-22 11:01:35.087599 | 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-22 11:01:35.173938 | debian-bookworm | Collecting types-setuptools 2025-08-22 11:01:35.181737 | debian-bookworm | Downloading types_setuptools-80.9.0.20250822-py3-none-any.whl (63 kB) 2025-08-22 11:01:35.189870 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.2/63.2 kB 11.1 MB/s eta 0:00:00 2025-08-22 11:01:35.195505 | 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-22 11:01:35.980922 | 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-22 11:01:36.496501 | 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-22 11:01:42.911290 | 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-22 11:01:42.911375 | 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-22 11:01:42.911396 | 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-22 11:01:42.911410 | debian-bookworm | Installing missing stub packages: 2025-08-22 11:01:42.911423 | 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-22 11:01:42.911458 | debian-bookworm | 2025-08-22 11:01:42.911471 | debian-bookworm | 2025-08-22 11:01:42.911483 | debian-bookworm | Success: no issues found in 65 source files 2025-08-22 11:01:43.229228 | debian-bookworm | ok: Runtime: 0:00:23.892133 2025-08-22 11:01:43.247240 | 2025-08-22 11:01:43.247382 | PLAY RECAP 2025-08-22 11:01:43.247487 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-08-22 11:01:43.247539 | 2025-08-22 11:01:43.377698 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-08-22 11:01:43.379920 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-22 11:01:44.172450 | 2025-08-22 11:01:44.172608 | PLAY [Base post] 2025-08-22 11:01:44.186315 | 2025-08-22 11:01:44.186444 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-22 11:01:44.795399 | debian-bookworm | changed 2025-08-22 11:01:44.805604 | 2025-08-22 11:01:44.805744 | PLAY RECAP 2025-08-22 11:01:44.805822 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-22 11:01:44.805896 | 2025-08-22 11:01:44.950910 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-22 11:01:44.953599 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-22 11:01:45.718125 | 2025-08-22 11:01:45.718286 | PLAY [Base post-logs] 2025-08-22 11:01:45.728789 | 2025-08-22 11:01:45.728912 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-22 11:01:46.183752 | localhost | changed 2025-08-22 11:01:46.199665 | 2025-08-22 11:01:46.199835 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-22 11:01:46.226429 | localhost | ok 2025-08-22 11:01:46.231442 | 2025-08-22 11:01:46.231579 | TASK [Set zuul-log-path fact] 2025-08-22 11:01:46.259159 | localhost | ok 2025-08-22 11:01:46.272389 | 2025-08-22 11:01:46.272518 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-22 11:01:46.309187 | localhost | ok 2025-08-22 11:01:46.314520 | 2025-08-22 11:01:46.314675 | TASK [upload-logs : Create log directories] 2025-08-22 11:01:46.831273 | localhost | changed 2025-08-22 11:01:46.834167 | 2025-08-22 11:01:46.834276 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-22 11:01:47.376142 | localhost -> localhost | ok: Runtime: 0:00:00.006867 2025-08-22 11:01:47.380308 | 2025-08-22 11:01:47.380424 | TASK [upload-logs : Upload logs to log server] 2025-08-22 11:01:47.957980 | localhost | Output suppressed because no_log was given 2025-08-22 11:01:47.962216 | 2025-08-22 11:01:47.962463 | LOOP [upload-logs : Compress console log and json output] 2025-08-22 11:01:48.019183 | localhost | skipping: Conditional result was False 2025-08-22 11:01:48.027944 | localhost | skipping: Conditional result was False 2025-08-22 11:01:48.044942 | 2025-08-22 11:01:48.045150 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-22 11:01:48.094718 | localhost | skipping: Conditional result was False 2025-08-22 11:01:48.095040 | 2025-08-22 11:01:48.101757 | localhost | skipping: Conditional result was False 2025-08-22 11:01:48.111754 | 2025-08-22 11:01:48.111991 | LOOP [upload-logs : Upload console log and json output]