2025-01-27 18:31:56.550826 | Job console starting... 2025-01-27 18:31:56.573218 | Updating repositories 2025-01-27 18:31:56.653260 | Preparing job workspace 2025-01-27 18:31:59.148083 | Running Ansible setup... 2025-01-27 18:32:05.854231 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-27 18:32:06.975469 | 2025-01-27 18:32:06.975643 | PLAY [Base pre] 2025-01-27 18:32:07.066024 | 2025-01-27 18:32:07.066288 | TASK [Setup log path fact] 2025-01-27 18:32:07.141579 | ubuntu-noble | ok 2025-01-27 18:32:07.185459 | 2025-01-27 18:32:07.185640 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:32:07.245554 | ubuntu-noble | ok 2025-01-27 18:32:07.260932 | 2025-01-27 18:32:07.261080 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:32:07.362745 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:07.371770 | 2025-01-27 18:32:07.371917 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:32:07.482798 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:07.491189 | 2025-01-27 18:32:07.491341 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:32:07.548872 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:07.557725 | 2025-01-27 18:32:07.557861 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:32:07.585759 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:07.593268 | 2025-01-27 18:32:07.593405 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:32:07.636648 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:07.651926 | 2025-01-27 18:32:07.652086 | TASK [emit-job-header : Print job information] 2025-01-27 18:32:07.795925 | # Job Information 2025-01-27 18:32:07.796148 | Ansible Version: 2.15.3 2025-01-27 18:32:07.796183 | Job: mypy 2025-01-27 18:32:07.796212 | Pipeline: check 2025-01-27 18:32:07.796233 | Executor: 7d211f194f6a 2025-01-27 18:32:07.796252 | Triggered by: https://github.com/osism/openstack-image-manager/pull/873 2025-01-27 18:32:07.796270 | Event ID: f7d63060-dcdc-11ef-9eb2-4f89d75c0d57 2025-01-27 18:32:07.806246 | 2025-01-27 18:32:07.806361 | LOOP [emit-job-header : Print node information] 2025-01-27 18:32:08.174095 | ubuntu-noble | ok: 2025-01-27 18:32:08.174233 | ubuntu-noble | # Node Information 2025-01-27 18:32:08.174260 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-27 18:32:08.174279 | ubuntu-noble | Hostname: ubuntu 2025-01-27 18:32:08.174297 | ubuntu-noble | Username: zuul 2025-01-27 18:32:08.174312 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-27 18:32:08.174328 | ubuntu-noble | Provider: regiocloud-a 2025-01-27 18:32:08.174344 | ubuntu-noble | Label: ubuntu-noble 2025-01-27 18:32:08.174359 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-27 18:32:08.174376 | ubuntu-noble | Interface IP: 81.163.192.60 2025-01-27 18:32:08.191620 | 2025-01-27 18:32:08.191729 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-27 18:32:09.027756 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:09.035891 | 2025-01-27 18:32:09.036008 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-27 18:32:10.513069 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:10.524673 | 2025-01-27 18:32:10.524757 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-27 18:32:11.115422 | ubuntu-noble -> localhost | ok 2025-01-27 18:32:11.123231 | 2025-01-27 18:32:11.123326 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-27 18:32:11.163643 | ubuntu-noble | ok 2025-01-27 18:32:11.185819 | ubuntu-noble | included: /var/lib/zuul/builds/a3ab9aabd79d47bf9dd18fa1d5c99506/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-27 18:32:11.194391 | 2025-01-27 18:32:11.194481 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-27 18:32:12.145051 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-27 18:32:12.145239 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a3ab9aabd79d47bf9dd18fa1d5c99506/work/a3ab9aabd79d47bf9dd18fa1d5c99506_id_rsa 2025-01-27 18:32:12.145276 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a3ab9aabd79d47bf9dd18fa1d5c99506/work/a3ab9aabd79d47bf9dd18fa1d5c99506_id_rsa.pub 2025-01-27 18:32:12.145301 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-27 18:32:12.145323 | ubuntu-noble -> localhost | SHA256:21U1PSW4/hQdFiqNk409ga2re0MTFcS2TcytG8nzTvE zuul-build-sshkey 2025-01-27 18:32:12.145345 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-27 18:32:12.145370 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-27 18:32:12.145392 | ubuntu-noble -> localhost | | ===oB| 2025-01-27 18:32:12.145412 | ubuntu-noble -> localhost | | .O=oX+| 2025-01-27 18:32:12.145432 | ubuntu-noble -> localhost | | *+O*+o| 2025-01-27 18:32:12.145451 | ubuntu-noble -> localhost | | o+oOo.| 2025-01-27 18:32:12.145470 | ubuntu-noble -> localhost | | S .+ *o| 2025-01-27 18:32:12.145489 | ubuntu-noble -> localhost | | o =. o E| 2025-01-27 18:32:12.145508 | ubuntu-noble -> localhost | | . + .o o | 2025-01-27 18:32:12.145527 | ubuntu-noble -> localhost | | . o . .| 2025-01-27 18:32:12.145547 | ubuntu-noble -> localhost | | .o . | 2025-01-27 18:32:12.145566 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-27 18:32:12.145610 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.278078 2025-01-27 18:32:12.152895 | 2025-01-27 18:32:12.153010 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-27 18:32:12.214015 | ubuntu-noble | ok 2025-01-27 18:32:12.232959 | ubuntu-noble | included: /var/lib/zuul/builds/a3ab9aabd79d47bf9dd18fa1d5c99506/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-27 18:32:12.242423 | 2025-01-27 18:32:12.242517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-27 18:32:12.296094 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:12.303558 | 2025-01-27 18:32:12.303665 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-27 18:32:13.034689 | ubuntu-noble | changed 2025-01-27 18:32:13.040236 | 2025-01-27 18:32:13.040309 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-27 18:32:13.332666 | ubuntu-noble | ok 2025-01-27 18:32:13.343777 | 2025-01-27 18:32:13.343867 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-27 18:32:13.980597 | ubuntu-noble | changed 2025-01-27 18:32:13.994147 | 2025-01-27 18:32:13.994286 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-27 18:32:14.618734 | ubuntu-noble | changed 2025-01-27 18:32:14.628305 | 2025-01-27 18:32:14.628427 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-27 18:32:14.663157 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:14.672128 | 2025-01-27 18:32:14.672238 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-27 18:32:15.123528 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:15.138395 | 2025-01-27 18:32:15.138494 | TASK [add-build-sshkey : Add back temp key] 2025-01-27 18:32:15.533305 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a3ab9aabd79d47bf9dd18fa1d5c99506/work/a3ab9aabd79d47bf9dd18fa1d5c99506_id_rsa (zuul-build-sshkey) 2025-01-27 18:32:15.533498 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010841 2025-01-27 18:32:15.540781 | 2025-01-27 18:32:15.540881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-27 18:32:15.890615 | ubuntu-noble | ok 2025-01-27 18:32:15.897041 | 2025-01-27 18:32:15.897139 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-27 18:32:15.941820 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:15.955262 | 2025-01-27 18:32:15.955355 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-27 18:32:16.380948 | ubuntu-noble | ok 2025-01-27 18:32:16.401590 | 2025-01-27 18:32:16.401695 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-27 18:32:16.460108 | ubuntu-noble | ok 2025-01-27 18:32:16.475121 | 2025-01-27 18:32:16.475232 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-27 18:32:17.140265 | ubuntu-noble -> localhost | ok 2025-01-27 18:32:17.148184 | 2025-01-27 18:32:17.148278 | TASK [validate-host : Collect information about the host] 2025-01-27 18:32:18.347501 | ubuntu-noble | ok 2025-01-27 18:32:18.404038 | 2025-01-27 18:32:18.404356 | TASK [validate-host : Sanitize hostname] 2025-01-27 18:32:18.486049 | ubuntu-noble | ok 2025-01-27 18:32:18.494227 | 2025-01-27 18:32:18.494354 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-27 18:32:19.106255 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:19.113338 | 2025-01-27 18:32:19.113437 | TASK [validate-host : Collect information about zuul worker] 2025-01-27 18:32:19.589326 | ubuntu-noble | ok 2025-01-27 18:32:19.595390 | 2025-01-27 18:32:19.595491 | TASK [validate-host : Write out all zuul information for each host] 2025-01-27 18:32:20.284816 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:20.309863 | 2025-01-27 18:32:20.310030 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-27 18:32:20.643720 | ubuntu-noble | ok 2025-01-27 18:32:20.661892 | 2025-01-27 18:32:20.662068 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-27 18:32:22.297573 | ubuntu-noble | changed: 2025-01-27 18:32:22.297803 | ubuntu-noble | cd+++++++++ src/ 2025-01-27 18:32:22.297844 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-27 18:32:22.297873 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-27 18:32:22.297900 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-27 18:32:22.297925 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-27 18:33:17.638077 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-27 18:33:17.665818 | ubuntu-noble | Downloading types_decorator-5.1.8.20250121-py3-none-any.whl (8.1 kB) 2025-01-27 18:33:17.696058 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-27 18:33:17.729463 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-27 18:33:17.754010 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-27 18:33:18.071041 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-27 18:33:18.185134 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.1.8.20250121 types-requests-2.32.0.20241016 types-simplejson-3.19.0.20241221 types-tabulate-0.9.0.20241207 2025-01-27 18:33:21.383449 | ubuntu-noble | Installing missing stub packages: 2025-01-27 18:33:21.398438 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-27 18:33:21.398488 | ubuntu-noble | 2025-01-27 18:33:21.398495 | ubuntu-noble | 2025-01-27 18:33:21.398499 | ubuntu-noble | Success: no issues found in 11 source files 2025-01-27 18:33:21.729661 | ubuntu-noble | ok 2025-01-27 18:33:21.773798 | 2025-01-27 18:33:21.773963 | PLAY RECAP 2025-01-27 18:33:21.774068 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-27 18:33:21.774105 | 2025-01-27 18:33:21.911707 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-27 18:33:21.917808 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-27 18:33:22.667193 | 2025-01-27 18:33:22.667374 | PLAY [Base post] 2025-01-27 18:33:22.696698 | 2025-01-27 18:33:22.696843 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-27 18:33:23.326300 | ubuntu-noble | changed 2025-01-27 18:33:23.371962 | 2025-01-27 18:33:23.372307 | PLAY RECAP 2025-01-27 18:33:23.372454 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-27 18:33:23.372524 | 2025-01-27 18:33:23.517533 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-27 18:33:23.520182 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-27 18:33:24.311412 | 2025-01-27 18:33:24.311619 | PLAY [Base post-logs] 2025-01-27 18:33:24.329042 | 2025-01-27 18:33:24.329184 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-27 18:33:24.842678 | localhost | changed 2025-01-27 18:33:24.846852 | 2025-01-27 18:33:24.846989 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-27 18:33:24.897992 | localhost | ok 2025-01-27 18:33:24.905888 | 2025-01-27 18:33:24.906032 | TASK [Set zuul-log-path fact] 2025-01-27 18:33:24.931748 | localhost | ok 2025-01-27 18:33:24.958382 | 2025-01-27 18:33:24.958508 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:33:25.021401 | localhost | ok 2025-01-27 18:33:25.025975 | 2025-01-27 18:33:25.026106 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:33:25.073644 | localhost | skipping: Conditional result was False 2025-01-27 18:33:25.080186 | 2025-01-27 18:33:25.080326 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:33:25.126437 | localhost | skipping: Conditional result was False 2025-01-27 18:33:25.133241 | 2025-01-27 18:33:25.133411 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:33:25.160484 | localhost | skipping: Conditional result was False 2025-01-27 18:33:25.170391 | 2025-01-27 18:33:25.170591 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:33:25.197847 | localhost | skipping: Conditional result was False 2025-01-27 18:33:25.202996 | 2025-01-27 18:33:25.203132 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:33:25.227920 | localhost | skipping: Conditional result was False 2025-01-27 18:33:25.235251 | 2025-01-27 18:33:25.235367 | TASK [upload-logs : Create log directories] 2025-01-27 18:33:25.788759 | localhost | changed 2025-01-27 18:33:25.795732 | 2025-01-27 18:33:25.796072 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-27 18:33:26.313380 | localhost -> localhost | ok: Runtime: 0:00:00.005670 2025-01-27 18:33:26.318891 | 2025-01-27 18:33:26.318996 | TASK [upload-logs : Upload logs to log server] 2025-01-27 18:33:26.910121 | localhost | Output suppressed because no_log was given 2025-01-27 18:33:26.913668 | 2025-01-27 18:33:26.913770 | LOOP [upload-logs : Compress console log and json output] 2025-01-27 18:33:26.983439 | localhost | skipping: Conditional result was False 2025-01-27 18:33:27.000780 | localhost | skipping: Conditional result was False 2025-01-27 18:33:27.021956 | 2025-01-27 18:33:27.022169 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-27 18:33:27.090278 | localhost | skipping: Conditional result was False 2025-01-27 18:33:27.095577 | 2025-01-27 18:33:27.104160 | localhost | skipping: Conditional result was False 2025-01-27 18:33:27.120988 | 2025-01-27 18:33:27.121146 | LOOP [upload-logs : Upload console log and json output]