2025-01-08 11:36:22.447077 | Job console starting... 2025-01-08 11:36:22.466378 | Updating repositories 2025-01-08 11:36:22.536859 | Preparing job workspace 2025-01-08 11:36:24.016301 | Running Ansible setup... 2025-01-08 11:36:29.208740 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 11:36:30.237507 | 2025-01-08 11:36:30.237668 | PLAY [Base pre] 2025-01-08 11:36:30.283487 | 2025-01-08 11:36:30.283637 | TASK [Setup log path fact] 2025-01-08 11:36:30.343464 | ubuntu-noble | ok 2025-01-08 11:36:30.381868 | 2025-01-08 11:36:30.382068 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:36:30.457268 | ubuntu-noble | ok 2025-01-08 11:36:30.464919 | 2025-01-08 11:36:30.465060 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:36:30.515086 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:30.524675 | 2025-01-08 11:36:30.524826 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:36:30.602752 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:30.620804 | 2025-01-08 11:36:30.621055 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:36:30.665780 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:30.681152 | 2025-01-08 11:36:30.681313 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:36:30.759031 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:30.768554 | 2025-01-08 11:36:30.768907 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:36:30.810514 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:30.836582 | 2025-01-08 11:36:30.836960 | TASK [emit-job-header : Print job information] 2025-01-08 11:36:30.926890 | # Job Information 2025-01-08 11:36:30.927097 | Ansible Version: 2.15.3 2025-01-08 11:36:30.927129 | Job: mypy 2025-01-08 11:36:30.927159 | Pipeline: check 2025-01-08 11:36:30.927180 | Executor: 7d211f194f6a 2025-01-08 11:36:30.927221 | Triggered by: https://github.com/osism/openstack-image-manager/pull/867 2025-01-08 11:36:30.927240 | Event ID: af324790-cdb4-11ef-808c-57368555ff30 2025-01-08 11:36:30.934930 | 2025-01-08 11:36:30.935055 | LOOP [emit-job-header : Print node information] 2025-01-08 11:36:31.134886 | ubuntu-noble | ok: 2025-01-08 11:36:31.135172 | ubuntu-noble | # Node Information 2025-01-08 11:36:31.135252 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 11:36:31.135278 | ubuntu-noble | Hostname: ubuntu 2025-01-08 11:36:31.135299 | ubuntu-noble | Username: zuul 2025-01-08 11:36:31.135319 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 11:36:31.135339 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 11:36:31.135357 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 11:36:31.135375 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 11:36:31.135395 | ubuntu-noble | Interface IP: 81.163.193.54 2025-01-08 11:36:31.157970 | 2025-01-08 11:36:31.158129 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 11:36:31.756180 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:31.764064 | 2025-01-08 11:36:31.764154 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 11:36:33.012772 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:33.033602 | 2025-01-08 11:36:33.033699 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 11:36:33.284915 | ubuntu-noble -> localhost | ok 2025-01-08 11:36:33.294233 | 2025-01-08 11:36:33.294331 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 11:36:33.321702 | ubuntu-noble | ok 2025-01-08 11:36:33.345363 | ubuntu-noble | included: /var/lib/zuul/builds/d23e556122544b17b7da0577d7a95a70/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 11:36:33.357004 | 2025-01-08 11:36:33.357085 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 11:36:33.995947 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 11:36:33.996178 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d23e556122544b17b7da0577d7a95a70/work/d23e556122544b17b7da0577d7a95a70_id_rsa 2025-01-08 11:36:33.996233 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d23e556122544b17b7da0577d7a95a70/work/d23e556122544b17b7da0577d7a95a70_id_rsa.pub 2025-01-08 11:36:33.996260 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 11:36:33.996287 | ubuntu-noble -> localhost | SHA256:k7AzV3tSEu/uNB781HTua0kbbzSEA17SY6xb04OerIE zuul-build-sshkey 2025-01-08 11:36:33.996311 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 11:36:33.996338 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 11:36:33.996362 | ubuntu-noble -> localhost | | . o | 2025-01-08 11:36:33.996384 | ubuntu-noble -> localhost | | = * | 2025-01-08 11:36:33.996405 | ubuntu-noble -> localhost | | . + O = | 2025-01-08 11:36:33.996426 | ubuntu-noble -> localhost | | o o B * + | 2025-01-08 11:36:33.996446 | ubuntu-noble -> localhost | | + S + B = +| 2025-01-08 11:36:33.996466 | ubuntu-noble -> localhost | | + E B + Bo| 2025-01-08 11:36:33.996487 | ubuntu-noble -> localhost | | O o.O| 2025-01-08 11:36:33.996508 | ubuntu-noble -> localhost | | = = =o| 2025-01-08 11:36:33.996529 | ubuntu-noble -> localhost | | o ooo| 2025-01-08 11:36:33.996550 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 11:36:33.996601 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.088745 2025-01-08 11:36:34.011508 | 2025-01-08 11:36:34.011639 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 11:36:34.043102 | ubuntu-noble | ok 2025-01-08 11:36:34.055879 | ubuntu-noble | included: /var/lib/zuul/builds/d23e556122544b17b7da0577d7a95a70/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 11:36:34.066649 | 2025-01-08 11:36:34.066739 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 11:36:34.090570 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:34.101145 | 2025-01-08 11:36:34.101260 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 11:36:34.863523 | ubuntu-noble | changed 2025-01-08 11:36:34.871032 | 2025-01-08 11:36:34.871126 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 11:36:35.191170 | ubuntu-noble | ok 2025-01-08 11:36:35.212868 | 2025-01-08 11:36:35.212982 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 11:36:36.057820 | ubuntu-noble | changed 2025-01-08 11:36:36.068839 | 2025-01-08 11:36:36.068956 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 11:36:36.897899 | ubuntu-noble | changed 2025-01-08 11:36:36.904774 | 2025-01-08 11:36:36.904863 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 11:36:36.940332 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:36.952837 | 2025-01-08 11:36:36.953303 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 11:36:37.726978 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:37.749186 | 2025-01-08 11:36:37.749304 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 11:36:38.662109 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d23e556122544b17b7da0577d7a95a70/work/d23e556122544b17b7da0577d7a95a70_id_rsa (zuul-build-sshkey) 2025-01-08 11:36:38.662280 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.061001 2025-01-08 11:36:38.668952 | 2025-01-08 11:36:38.669041 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 11:36:39.229368 | ubuntu-noble | ok 2025-01-08 11:36:39.237490 | 2025-01-08 11:36:39.237589 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 11:36:39.294130 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:39.338718 | 2025-01-08 11:36:39.342977 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 11:36:40.000279 | ubuntu-noble | ok 2025-01-08 11:36:40.120002 | 2025-01-08 11:36:40.120110 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 11:36:40.291902 | ubuntu-noble | ok 2025-01-08 11:36:40.301109 | 2025-01-08 11:36:40.301220 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 11:36:41.059497 | ubuntu-noble -> localhost | ok 2025-01-08 11:36:41.065366 | 2025-01-08 11:36:41.065445 | TASK [validate-host : Collect information about the host] 2025-01-08 11:36:42.305579 | ubuntu-noble | ok 2025-01-08 11:36:42.339776 | 2025-01-08 11:36:42.339880 | TASK [validate-host : Sanitize hostname] 2025-01-08 11:36:42.523557 | ubuntu-noble | ok 2025-01-08 11:36:42.562658 | 2025-01-08 11:36:42.562761 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 11:36:43.872661 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:43.882841 | 2025-01-08 11:36:43.882999 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 11:36:44.635352 | ubuntu-noble | ok 2025-01-08 11:36:44.647871 | 2025-01-08 11:36:44.647967 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 11:36:45.696508 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:45.730407 | 2025-01-08 11:36:45.730506 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 11:36:46.117783 | ubuntu-noble | ok 2025-01-08 11:36:46.130894 | 2025-01-08 11:36:46.130978 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 11:36:47.442118 | ubuntu-noble | changed: 2025-01-08 11:36:47.442263 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 11:36:47.442290 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 11:36:47.442311 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 11:36:47.442329 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 11:36:47.442346 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-08 11:37:48.080365 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-08 11:37:48.112617 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-08 11:37:48.138191 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-08 11:37:48.164421 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-08 11:37:48.191890 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-08 11:37:48.461477 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-08 11:37:48.586425 | 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:37:52.959749 | ubuntu-noble | Installing missing stub packages: 2025-01-08 11:37:52.980447 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-08 11:37:52.980554 | ubuntu-noble | 2025-01-08 11:37:52.980573 | ubuntu-noble | 2025-01-08 11:37:52.980603 | ubuntu-noble | Success: no issues found in 11 source files 2025-01-08 11:37:53.142156 | ubuntu-noble | ok 2025-01-08 11:37:53.186356 | 2025-01-08 11:37:53.186471 | PLAY RECAP 2025-01-08 11:37:53.186531 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-08 11:37:53.186560 | 2025-01-08 11:37:53.332783 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-08 11:37:53.340151 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:37:54.043348 | 2025-01-08 11:37:54.043615 | PLAY [Base post] 2025-01-08 11:37:54.072337 | 2025-01-08 11:37:54.072507 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-08 11:37:54.727968 | ubuntu-noble | changed 2025-01-08 11:37:54.759753 | 2025-01-08 11:37:54.759900 | PLAY RECAP 2025-01-08 11:37:54.759977 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-08 11:37:54.760047 | 2025-01-08 11:37:54.889789 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:37:54.907071 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-08 11:37:55.701852 | 2025-01-08 11:37:55.702069 | PLAY [Base post-logs] 2025-01-08 11:37:55.718318 | 2025-01-08 11:37:55.718456 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-08 11:37:56.166856 | localhost | changed 2025-01-08 11:37:56.170858 | 2025-01-08 11:37:56.171003 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-08 11:37:56.208205 | localhost | ok 2025-01-08 11:37:56.214259 | 2025-01-08 11:37:56.214365 | TASK [Set zuul-log-path fact] 2025-01-08 11:37:56.231275 | localhost | ok 2025-01-08 11:37:56.245000 | 2025-01-08 11:37:56.245117 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:37:56.298931 | localhost | ok 2025-01-08 11:37:56.302111 | 2025-01-08 11:37:56.302225 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:37:56.347123 | localhost | skipping: Conditional result was False 2025-01-08 11:37:56.355650 | 2025-01-08 11:37:56.355842 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:37:56.404343 | localhost | skipping: Conditional result was False 2025-01-08 11:37:56.413113 | 2025-01-08 11:37:56.413326 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:37:56.430673 | localhost | skipping: Conditional result was False 2025-01-08 11:37:56.436582 | 2025-01-08 11:37:56.436740 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:37:56.462544 | localhost | skipping: Conditional result was False 2025-01-08 11:37:56.471841 | 2025-01-08 11:37:56.472025 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:37:56.498189 | localhost | skipping: Conditional result was False 2025-01-08 11:37:56.511052 | 2025-01-08 11:37:56.511232 | TASK [upload-logs : Create log directories] 2025-01-08 11:37:57.072434 | localhost | changed 2025-01-08 11:37:57.082699 | 2025-01-08 11:37:57.082864 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-08 11:37:57.645341 | localhost -> localhost | ok: Runtime: 0:00:00.006952 2025-01-08 11:37:57.651586 | 2025-01-08 11:37:57.651705 | TASK [upload-logs : Upload logs to log server] 2025-01-08 11:37:58.332140 | localhost | Output suppressed because no_log was given 2025-01-08 11:37:58.335828 | 2025-01-08 11:37:58.335937 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 11:37:58.431489 | localhost | skipping: Conditional result was False 2025-01-08 11:37:58.477608 | localhost | skipping: Conditional result was False 2025-01-08 11:37:58.491707 | 2025-01-08 11:37:58.491857 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 11:37:58.569106 | localhost | skipping: Conditional result was False 2025-01-08 11:37:58.569458 | 2025-01-08 11:37:58.585331 | localhost | skipping: Conditional result was False 2025-01-08 11:37:58.594973 | 2025-01-08 11:37:58.595103 | LOOP [upload-logs : Upload console log and json output]