2025-08-23 09:53:36.652101 | Job console starting 2025-08-23 09:53:36.659908 | Updating git repos 2025-08-23 09:53:36.993088 | Cloning repos into workspace 2025-08-23 09:53:37.056522 | Restoring repo states 2025-08-23 09:53:37.064309 | Merging changes 2025-08-23 09:53:37.666416 | Checking out repos 2025-08-23 09:53:37.798480 | Preparing playbooks 2025-08-23 09:53:38.898914 | Running Ansible setup 2025-08-23 09:53:45.787452 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 09:53:47.236992 | 2025-08-23 09:53:47.237121 | PLAY [Base pre] 2025-08-23 09:53:47.253169 | 2025-08-23 09:53:47.253274 | TASK [Setup log path fact] 2025-08-23 09:53:47.270944 | debian-bookworm | ok 2025-08-23 09:53:47.298675 | 2025-08-23 09:53:47.298846 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:53:47.359240 | debian-bookworm | ok 2025-08-23 09:53:47.369932 | 2025-08-23 09:53:47.370045 | TASK [emit-job-header : Print job information] 2025-08-23 09:53:47.462054 | # Job Information 2025-08-23 09:53:47.462215 | Ansible Version: 2.16.14 2025-08-23 09:53:47.462249 | Job: mypy 2025-08-23 09:53:47.462282 | Pipeline: check 2025-08-23 09:53:47.462305 | Executor: 521e9411259a 2025-08-23 09:53:47.462325 | Triggered by: https://github.com/osism/python-osism/pull/1655 2025-08-23 09:53:47.462347 | Event ID: 046723c0-8007-11f0-9935-8ffb18e3020a 2025-08-23 09:53:47.467950 | 2025-08-23 09:53:47.468062 | LOOP [emit-job-header : Print node information] 2025-08-23 09:53:47.663204 | debian-bookworm | ok: 2025-08-23 09:53:47.663453 | debian-bookworm | # Node Information 2025-08-23 09:53:47.663492 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 09:53:47.663518 | debian-bookworm | Hostname: debian 2025-08-23 09:53:47.663540 | debian-bookworm | Username: zuul 2025-08-23 09:53:47.663561 | debian-bookworm | Distro: Debian 12.11 2025-08-23 09:53:47.663584 | debian-bookworm | Provider: regiocloud-a 2025-08-23 09:53:47.663604 | debian-bookworm | Region: 2025-08-23 09:53:47.663625 | debian-bookworm | Label: debian-bookworm 2025-08-23 09:53:47.663644 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 09:53:47.663663 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:c254 2025-08-23 09:53:47.684231 | 2025-08-23 09:53:47.684350 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 09:53:48.334120 | debian-bookworm -> localhost | changed 2025-08-23 09:53:48.341489 | 2025-08-23 09:53:48.341593 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 09:53:50.267752 | debian-bookworm -> localhost | changed 2025-08-23 09:53:50.276470 | 2025-08-23 09:53:50.276565 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 09:53:50.690643 | debian-bookworm -> localhost | ok 2025-08-23 09:53:50.695779 | 2025-08-23 09:53:50.695897 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 09:53:50.732389 | debian-bookworm | ok 2025-08-23 09:53:50.764596 | debian-bookworm | included: /var/lib/zuul/builds/e13228c2adde4d358558437689bdaa7a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 09:53:50.769508 | 2025-08-23 09:53:50.769591 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 09:53:52.871104 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 09:53:52.871279 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e13228c2adde4d358558437689bdaa7a/work/e13228c2adde4d358558437689bdaa7a_id_rsa 2025-08-23 09:53:52.871309 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e13228c2adde4d358558437689bdaa7a/work/e13228c2adde4d358558437689bdaa7a_id_rsa.pub 2025-08-23 09:53:52.871331 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 09:53:52.871351 | debian-bookworm -> localhost | SHA256:mtCyxo1KcJ05cie65DmVjP0x/NnrY9KqZNLxUtrpqCM zuul-build-sshkey 2025-08-23 09:53:52.871369 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 09:53:52.871395 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 09:53:52.871413 | debian-bookworm -> localhost | | | 2025-08-23 09:53:52.871431 | debian-bookworm -> localhost | | | 2025-08-23 09:53:52.871448 | debian-bookworm -> localhost | | | 2025-08-23 09:53:52.871464 | debian-bookworm -> localhost | | . + | 2025-08-23 09:53:52.871480 | debian-bookworm -> localhost | |. o+Xo+ S | 2025-08-23 09:53:52.871500 | debian-bookworm -> localhost | | o.==@+O . | 2025-08-23 09:53:52.871516 | debian-bookworm -> localhost | | +.*.X+++ | 2025-08-23 09:53:52.871533 | debian-bookworm -> localhost | | +E=.+.++ = | 2025-08-23 09:53:52.871550 | debian-bookworm -> localhost | | =o.oo.o=oo | 2025-08-23 09:53:52.871566 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 09:53:52.871611 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.146157 2025-08-23 09:53:52.876670 | 2025-08-23 09:53:52.876761 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 09:53:52.913397 | debian-bookworm | ok 2025-08-23 09:53:52.921099 | debian-bookworm | included: /var/lib/zuul/builds/e13228c2adde4d358558437689bdaa7a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 09:53:52.940012 | 2025-08-23 09:53:52.940114 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 09:53:52.979166 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:52.984208 | 2025-08-23 09:53:52.984300 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 09:53:53.614697 | debian-bookworm | changed 2025-08-23 09:53:53.649100 | 2025-08-23 09:53:53.649201 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 09:53:53.912419 | debian-bookworm | ok 2025-08-23 09:53:53.917917 | 2025-08-23 09:53:53.918075 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 09:53:54.633512 | debian-bookworm | changed 2025-08-23 09:53:54.640853 | 2025-08-23 09:53:54.640948 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 09:53:55.298818 | debian-bookworm | changed 2025-08-23 09:53:55.303301 | 2025-08-23 09:53:55.303375 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 09:53:55.356132 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:55.362390 | 2025-08-23 09:53:55.362480 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 09:53:56.509327 | debian-bookworm -> localhost | changed 2025-08-23 09:53:56.518102 | 2025-08-23 09:53:56.518188 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 09:53:57.005893 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e13228c2adde4d358558437689bdaa7a/work/e13228c2adde4d358558437689bdaa7a_id_rsa (zuul-build-sshkey) 2025-08-23 09:53:57.006094 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012292 2025-08-23 09:53:57.015374 | 2025-08-23 09:53:57.015467 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 09:53:57.558776 | debian-bookworm | ok 2025-08-23 09:53:57.587336 | 2025-08-23 09:53:57.587447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 09:53:57.630477 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:57.643289 | 2025-08-23 09:53:57.643394 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 09:53:58.185842 | debian-bookworm | ok 2025-08-23 09:53:58.199934 | 2025-08-23 09:53:58.200042 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 09:53:58.269598 | debian-bookworm | ok 2025-08-23 09:53:58.277657 | 2025-08-23 09:53:58.277754 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 09:53:58.946705 | debian-bookworm -> localhost | ok 2025-08-23 09:53:58.952991 | 2025-08-23 09:53:58.953088 | TASK [validate-host : Collect information about the host] 2025-08-23 09:54:00.182058 | debian-bookworm | ok 2025-08-23 09:54:00.196434 | 2025-08-23 09:54:00.196533 | TASK [validate-host : Sanitize hostname] 2025-08-23 09:54:00.314311 | debian-bookworm | ok 2025-08-23 09:54:00.414063 | 2025-08-23 09:54:00.414154 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 09:54:01.527891 | debian-bookworm -> localhost | changed 2025-08-23 09:54:01.533523 | 2025-08-23 09:54:01.533622 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 09:54:02.201071 | debian-bookworm | ok 2025-08-23 09:54:02.206488 | 2025-08-23 09:54:02.206586 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 09:54:03.195147 | debian-bookworm -> localhost | changed 2025-08-23 09:54:03.216435 | 2025-08-23 09:54:03.216522 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 09:54:03.533964 | debian-bookworm | ok 2025-08-23 09:54:03.538557 | 2025-08-23 09:54:03.538644 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 09:54:05.131195 | debian-bookworm | changed: 2025-08-23 09:54:05.131341 | debian-bookworm | cd+++++++++ src/ 2025-08-23 09:54:05.131369 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 09:54:05.131389 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 09:54:05.131406 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 09:54:05.131423 | debian-bookworm | Containerfile 2025-08-23 09:54:05.131515 | debian-bookworm | Containerfile 2025-08-23 09:54:05.181226 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (45.0.6) 2025-08-23 09:55:27.859966 | debian-bookworm | Collecting types-cffi 2025-08-23 09:55:27.871649 | debian-bookworm | Downloading types_cffi-1.17.0.20250822-py3-none-any.whl (20 kB) 2025-08-23 09:55:27.882294 | 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:27.909689 | 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:27.988832 | debian-bookworm | Collecting types-setuptools 2025-08-23 09:55:27.996824 | debian-bookworm | Downloading types_setuptools-80.9.0.20250822-py3-none-any.whl (63 kB) 2025-08-23 09:55:28.004825 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.2/63.2 kB 11.6 MB/s eta 0:00:00 2025-08-23 09:55:28.010219 | 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:28.772184 | 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:29.171201 | 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:36.769664 | 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:36.769821 | 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:36.769844 | 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:36.769858 | debian-bookworm | Installing missing stub packages: 2025-08-23 09:55:36.769871 | 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:36.769911 | debian-bookworm | 2025-08-23 09:55:36.769924 | debian-bookworm | 2025-08-23 09:55:36.769935 | debian-bookworm | Success: no issues found in 65 source files 2025-08-23 09:55:36.932710 | debian-bookworm | ok: Runtime: 0:00:26.141669 2025-08-23 09:55:36.942981 | 2025-08-23 09:55:36.943088 | PLAY RECAP 2025-08-23 09:55:36.943144 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-08-23 09:55:36.943169 | 2025-08-23 09:55:37.150076 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-08-23 09:55:37.151374 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-23 09:55:38.187975 | 2025-08-23 09:55:38.188167 | PLAY [Base post] 2025-08-23 09:55:38.222125 | 2025-08-23 09:55:38.222289 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-23 09:55:39.066975 | debian-bookworm | changed 2025-08-23 09:55:39.076712 | 2025-08-23 09:55:39.076867 | PLAY RECAP 2025-08-23 09:55:39.076932 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-23 09:55:39.076993 | 2025-08-23 09:55:39.363341 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-23 09:55:39.364805 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-23 09:55:40.337268 | 2025-08-23 09:55:40.337395 | PLAY [Base post-logs] 2025-08-23 09:55:40.353034 | 2025-08-23 09:55:40.353148 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-23 09:55:40.753365 | localhost | changed 2025-08-23 09:55:40.767435 | 2025-08-23 09:55:40.767570 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-23 09:55:40.791974 | localhost | ok 2025-08-23 09:55:40.794877 | 2025-08-23 09:55:40.794962 | TASK [Set zuul-log-path fact] 2025-08-23 09:55:40.808808 | localhost | ok 2025-08-23 09:55:40.815967 | 2025-08-23 09:55:40.816055 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:55:40.839842 | localhost | ok 2025-08-23 09:55:40.842512 | 2025-08-23 09:55:40.842595 | TASK [upload-logs : Create log directories] 2025-08-23 09:55:41.191355 | localhost | changed 2025-08-23 09:55:41.193904 | 2025-08-23 09:55:41.193990 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-23 09:55:41.741919 | localhost -> localhost | ok: Runtime: 0:00:00.013271 2025-08-23 09:55:41.745789 | 2025-08-23 09:55:41.745882 | TASK [upload-logs : Upload logs to log server] 2025-08-23 09:55:42.311821 | localhost | Output suppressed because no_log was given 2025-08-23 09:55:42.315158 | 2025-08-23 09:55:42.315299 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 09:55:42.373594 | localhost | skipping: Conditional result was False 2025-08-23 09:55:42.380751 | localhost | skipping: Conditional result was False 2025-08-23 09:55:42.390182 | 2025-08-23 09:55:42.390301 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 09:55:42.432046 | localhost | skipping: Conditional result was False 2025-08-23 09:55:42.432601 | 2025-08-23 09:55:42.435362 | localhost | skipping: Conditional result was False 2025-08-23 09:55:42.445777 | 2025-08-23 09:55:42.445868 | LOOP [upload-logs : Upload console log and json output]