2025-01-08 11:22:50.079732 | Job console starting... 2025-01-08 11:22:50.084909 | Updating repositories 2025-01-08 11:22:50.103599 | Preparing job workspace 2025-01-08 11:22:51.429937 | Running Ansible setup... 2025-01-08 11:22:57.678723 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 11:22:58.392285 | 2025-01-08 11:22:58.392401 | PLAY [Base pre] 2025-01-08 11:22:58.424085 | 2025-01-08 11:22:58.424187 | TASK [Setup log path fact] 2025-01-08 11:22:58.475637 | ubuntu-noble | ok 2025-01-08 11:22:58.562102 | 2025-01-08 11:22:58.562215 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:22:58.642330 | ubuntu-noble | ok 2025-01-08 11:22:58.650602 | 2025-01-08 11:22:58.650681 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:22:58.734649 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:58.740525 | 2025-01-08 11:22:58.740646 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:22:58.785845 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:58.792034 | 2025-01-08 11:22:58.792120 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:22:58.815126 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:58.820827 | 2025-01-08 11:22:58.820908 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:22:58.864036 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:58.869838 | 2025-01-08 11:22:58.869946 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:22:58.923468 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:58.935384 | 2025-01-08 11:22:58.935485 | TASK [emit-job-header : Print job information] 2025-01-08 11:22:58.984134 | # Job Information 2025-01-08 11:22:58.984271 | Ansible Version: 2.15.3 2025-01-08 11:22:58.984296 | Job: mypy 2025-01-08 11:22:58.984320 | Pipeline: check 2025-01-08 11:22:58.984337 | Executor: 7d211f194f6a 2025-01-08 11:22:58.984353 | Triggered by: https://github.com/osism/openstack-image-manager/pull/868 2025-01-08 11:22:58.984369 | Event ID: d81dd040-cdb2-11ef-95bf-d6ca19da912d 2025-01-08 11:22:58.989760 | 2025-01-08 11:22:58.989844 | LOOP [emit-job-header : Print node information] 2025-01-08 11:22:59.229424 | ubuntu-noble | ok: 2025-01-08 11:22:59.229608 | ubuntu-noble | # Node Information 2025-01-08 11:22:59.229643 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 11:22:59.229667 | ubuntu-noble | Hostname: ubuntu 2025-01-08 11:22:59.229688 | ubuntu-noble | Username: zuul 2025-01-08 11:22:59.229707 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 11:22:59.229726 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 11:22:59.229746 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 11:22:59.229765 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 11:22:59.229785 | ubuntu-noble | Interface IP: 81.163.193.202 2025-01-08 11:22:59.252733 | 2025-01-08 11:22:59.252830 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 11:23:00.088619 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:00.099922 | 2025-01-08 11:23:00.100026 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 11:23:01.683097 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:01.703299 | 2025-01-08 11:23:01.703399 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 11:23:02.193458 | ubuntu-noble -> localhost | ok 2025-01-08 11:23:02.201000 | 2025-01-08 11:23:02.201094 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 11:23:02.264903 | ubuntu-noble | ok 2025-01-08 11:23:02.281520 | ubuntu-noble | included: /var/lib/zuul/builds/593ddf7c9c0444fd83796496ea8db704/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 11:23:02.289465 | 2025-01-08 11:23:02.289583 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 11:23:03.394744 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 11:23:03.394904 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/593ddf7c9c0444fd83796496ea8db704/work/593ddf7c9c0444fd83796496ea8db704_id_rsa 2025-01-08 11:23:03.394934 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/593ddf7c9c0444fd83796496ea8db704/work/593ddf7c9c0444fd83796496ea8db704_id_rsa.pub 2025-01-08 11:23:03.394953 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 11:23:03.394972 | ubuntu-noble -> localhost | SHA256:YKQMT4q4moGSA4tv/mMaAeUnFObA9Gkil06+IsOXRQQ zuul-build-sshkey 2025-01-08 11:23:03.394990 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 11:23:03.395011 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 11:23:03.395029 | ubuntu-noble -> localhost | |+.*Eo.. | 2025-01-08 11:23:03.395045 | ubuntu-noble -> localhost | |.X.Boo | 2025-01-08 11:23:03.395061 | ubuntu-noble -> localhost | |*.O+=.o | 2025-01-08 11:23:03.395077 | ubuntu-noble -> localhost | |=Xoo.. . | 2025-01-08 11:23:03.395092 | ubuntu-noble -> localhost | |X + . S | 2025-01-08 11:23:03.395107 | ubuntu-noble -> localhost | |+= oo | 2025-01-08 11:23:03.395123 | ubuntu-noble -> localhost | |*.=o | 2025-01-08 11:23:03.395139 | ubuntu-noble -> localhost | |.=..o | 2025-01-08 11:23:03.395155 | ubuntu-noble -> localhost | | o+.. | 2025-01-08 11:23:03.395170 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 11:23:03.395206 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.441502 2025-01-08 11:23:03.401334 | 2025-01-08 11:23:03.401412 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 11:23:03.439336 | ubuntu-noble | ok 2025-01-08 11:23:03.454960 | ubuntu-noble | included: /var/lib/zuul/builds/593ddf7c9c0444fd83796496ea8db704/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 11:23:03.473292 | 2025-01-08 11:23:03.473367 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 11:23:03.516987 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:03.523290 | 2025-01-08 11:23:03.523377 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 11:23:04.309088 | ubuntu-noble | changed 2025-01-08 11:23:04.318629 | 2025-01-08 11:23:04.318706 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 11:23:04.578636 | ubuntu-noble | ok 2025-01-08 11:23:04.584461 | 2025-01-08 11:23:04.584536 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 11:23:05.285018 | ubuntu-noble | changed 2025-01-08 11:23:05.295386 | 2025-01-08 11:23:05.295461 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 11:23:06.006784 | ubuntu-noble | changed 2025-01-08 11:23:06.023722 | 2025-01-08 11:23:06.023827 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 11:23:06.048013 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:06.055247 | 2025-01-08 11:23:06.055337 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 11:23:06.618488 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:06.655977 | 2025-01-08 11:23:06.656078 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 11:23:07.027945 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/593ddf7c9c0444fd83796496ea8db704/work/593ddf7c9c0444fd83796496ea8db704_id_rsa (zuul-build-sshkey) 2025-01-08 11:23:07.028253 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009469 2025-01-08 11:23:07.039141 | 2025-01-08 11:23:07.039239 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 11:23:07.451449 | ubuntu-noble | ok 2025-01-08 11:23:07.459200 | 2025-01-08 11:23:07.459295 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 11:23:07.483193 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.495685 | 2025-01-08 11:23:07.495782 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 11:23:07.927366 | ubuntu-noble | ok 2025-01-08 11:23:07.947093 | 2025-01-08 11:23:07.947195 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 11:23:07.976954 | ubuntu-noble | ok 2025-01-08 11:23:07.983327 | 2025-01-08 11:23:07.983415 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 11:23:08.302237 | ubuntu-noble -> localhost | ok 2025-01-08 11:23:08.309804 | 2025-01-08 11:23:08.309899 | TASK [validate-host : Collect information about the host] 2025-01-08 11:23:09.430667 | ubuntu-noble | ok 2025-01-08 11:23:09.464179 | 2025-01-08 11:23:09.464295 | TASK [validate-host : Sanitize hostname] 2025-01-08 11:23:09.554999 | ubuntu-noble | ok 2025-01-08 11:23:09.560998 | 2025-01-08 11:23:09.561102 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 11:23:10.537673 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:10.545052 | 2025-01-08 11:23:10.545163 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 11:23:11.223588 | ubuntu-noble | ok 2025-01-08 11:23:11.233237 | 2025-01-08 11:23:11.233340 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 11:23:11.859634 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:11.878105 | 2025-01-08 11:23:11.878212 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 11:23:12.241547 | ubuntu-noble | ok 2025-01-08 11:23:12.255838 | 2025-01-08 11:23:12.255945 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 11:23:13.488701 | ubuntu-noble | changed: 2025-01-08 11:23:13.488857 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 11:23:13.488888 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 11:23:13.488913 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 11:23:13.488934 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 11:23:13.488955 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-08 11:24:15.859535 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-08 11:24:15.883146 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-08 11:24:15.906359 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-08 11:24:15.932214 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-08 11:24:15.955448 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-08 11:24:16.276153 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-08 11:24:16.387664 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.1.8.20240310 types-requests-2.32.0.20241016 types-simplejson-3.19.0.20241221 types-tabulate-0.9.0.20241207 2025-01-08 11:24:20.854941 | ubuntu-noble | Installing missing stub packages: 2025-01-08 11:24:20.876556 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-08 11:24:20.876787 | ubuntu-noble | 2025-01-08 11:24:20.876824 | ubuntu-noble | 2025-01-08 11:24:20.876844 | ubuntu-noble | Success: no issues found in 11 source files 2025-01-08 11:24:20.932326 | ubuntu-noble | ok 2025-01-08 11:24:20.969361 | 2025-01-08 11:24:20.969457 | PLAY RECAP 2025-01-08 11:24:20.969517 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-08 11:24:20.969544 | 2025-01-08 11:24:21.111047 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-08 11:24:21.113580 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:24:21.915371 | 2025-01-08 11:24:21.915539 | PLAY [Base post] 2025-01-08 11:24:21.955405 | 2025-01-08 11:24:21.955556 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-08 11:24:22.643546 | ubuntu-noble | changed 2025-01-08 11:24:22.674592 | 2025-01-08 11:24:22.674724 | PLAY RECAP 2025-01-08 11:24:22.674792 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-08 11:24:22.674853 | 2025-01-08 11:24:22.755893 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:24:22.758262 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-08 11:24:23.548748 | 2025-01-08 11:24:23.548883 | PLAY [Base post-logs] 2025-01-08 11:24:23.564048 | 2025-01-08 11:24:23.564156 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-08 11:24:23.998894 | localhost | changed 2025-01-08 11:24:24.002348 | 2025-01-08 11:24:24.002461 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-08 11:24:24.040364 | localhost | ok 2025-01-08 11:24:24.046628 | 2025-01-08 11:24:24.046750 | TASK [Set zuul-log-path fact] 2025-01-08 11:24:24.072906 | localhost | ok 2025-01-08 11:24:24.092160 | 2025-01-08 11:24:24.092292 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:24:24.143489 | localhost | ok 2025-01-08 11:24:24.150386 | 2025-01-08 11:24:24.150539 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:24:24.186089 | localhost | skipping: Conditional result was False 2025-01-08 11:24:24.193504 | 2025-01-08 11:24:24.193655 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:24:24.242804 | localhost | skipping: Conditional result was False 2025-01-08 11:24:24.251771 | 2025-01-08 11:24:24.251946 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:24:24.288531 | localhost | skipping: Conditional result was False 2025-01-08 11:24:24.300124 | 2025-01-08 11:24:24.300244 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:24:24.324435 | localhost | skipping: Conditional result was False 2025-01-08 11:24:24.335165 | 2025-01-08 11:24:24.335323 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:24:24.361723 | localhost | skipping: Conditional result was False 2025-01-08 11:24:24.375349 | 2025-01-08 11:24:24.375497 | TASK [upload-logs : Create log directories] 2025-01-08 11:24:24.878762 | localhost | changed 2025-01-08 11:24:24.885614 | 2025-01-08 11:24:24.885744 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-08 11:24:25.330994 | localhost -> localhost | ok: Runtime: 0:00:00.006856 2025-01-08 11:24:25.335854 | 2025-01-08 11:24:25.335946 | TASK [upload-logs : Upload logs to log server] 2025-01-08 11:24:25.923779 | localhost | Output suppressed because no_log was given 2025-01-08 11:24:25.926608 | 2025-01-08 11:24:25.926694 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 11:24:26.014687 | localhost | skipping: Conditional result was False 2025-01-08 11:24:26.032600 | localhost | skipping: Conditional result was False 2025-01-08 11:24:26.042761 | 2025-01-08 11:24:26.043161 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 11:24:26.125044 | localhost | skipping: Conditional result was False 2025-01-08 11:24:26.125360 | 2025-01-08 11:24:26.145127 | localhost | skipping: Conditional result was False 2025-01-08 11:24:26.151920 | 2025-01-08 11:24:26.152034 | LOOP [upload-logs : Upload console log and json output]