2025-01-07 15:13:55.859534 | Job console starting... 2025-01-07 15:13:55.892888 | Updating repositories 2025-01-07 15:13:55.963313 | Preparing job workspace 2025-01-07 15:13:58.417726 | Running Ansible setup... 2025-01-07 15:14:04.700604 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-07 15:14:06.094493 | 2025-01-07 15:14:06.094634 | PLAY [Base pre] 2025-01-07 15:14:06.150601 | 2025-01-07 15:14:06.150739 | TASK [Setup log path fact] 2025-01-07 15:14:06.173303 | ubuntu-noble | ok 2025-01-07 15:14:06.204678 | 2025-01-07 15:14:06.204805 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-07 15:14:06.288090 | ubuntu-noble | ok 2025-01-07 15:14:06.296106 | 2025-01-07 15:14:06.296209 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-07 15:14:06.363641 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:06.371946 | 2025-01-07 15:14:06.372068 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-07 15:14:06.475857 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:06.483419 | 2025-01-07 15:14:06.483849 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-07 15:14:06.537211 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:06.545258 | 2025-01-07 15:14:06.545357 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-07 15:14:06.626954 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:06.636005 | 2025-01-07 15:14:06.636104 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-07 15:14:06.660443 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:06.675526 | 2025-01-07 15:14:06.675652 | TASK [emit-job-header : Print job information] 2025-01-07 15:14:06.861029 | # Job Information 2025-01-07 15:14:06.861165 | Ansible Version: 2.15.3 2025-01-07 15:14:06.861190 | Job: mypy 2025-01-07 15:14:06.861214 | Pipeline: check 2025-01-07 15:14:06.861231 | Executor: 7d211f194f6a 2025-01-07 15:14:06.861247 | Triggered by: https://github.com/osism/openstack-image-manager/pull/866 2025-01-07 15:14:06.861262 | Event ID: fde35ab0-cd09-11ef-8ab6-0cb6762c8b95 2025-01-07 15:14:06.875194 | 2025-01-07 15:14:06.875291 | LOOP [emit-job-header : Print node information] 2025-01-07 15:14:07.163572 | ubuntu-noble | ok: 2025-01-07 15:14:07.163822 | ubuntu-noble | # Node Information 2025-01-07 15:14:07.164107 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-07 15:14:07.164153 | ubuntu-noble | Hostname: ubuntu 2025-01-07 15:14:07.164178 | ubuntu-noble | Username: zuul 2025-01-07 15:14:07.164200 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-07 15:14:07.164220 | ubuntu-noble | Provider: regiocloud-a 2025-01-07 15:14:07.164307 | ubuntu-noble | Label: ubuntu-noble 2025-01-07 15:14:07.164335 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-07 15:14:07.164357 | ubuntu-noble | Interface IP: 81.163.192.227 2025-01-07 15:14:07.187563 | 2025-01-07 15:14:07.187673 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-07 15:14:08.179861 | ubuntu-noble -> localhost | changed 2025-01-07 15:14:08.186419 | 2025-01-07 15:14:08.186505 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-07 15:14:09.471231 | ubuntu-noble -> localhost | changed 2025-01-07 15:14:09.488021 | 2025-01-07 15:14:09.488129 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-07 15:14:09.861272 | ubuntu-noble -> localhost | ok 2025-01-07 15:14:09.867764 | 2025-01-07 15:14:09.867856 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-07 15:14:09.939741 | ubuntu-noble | ok 2025-01-07 15:14:09.981221 | ubuntu-noble | included: /var/lib/zuul/builds/b085d70affb948d88a1aaba1ab694af4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-07 15:14:10.003877 | 2025-01-07 15:14:10.003998 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-07 15:14:11.469091 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-07 15:14:11.469250 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b085d70affb948d88a1aaba1ab694af4/work/b085d70affb948d88a1aaba1ab694af4_id_rsa 2025-01-07 15:14:11.469280 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b085d70affb948d88a1aaba1ab694af4/work/b085d70affb948d88a1aaba1ab694af4_id_rsa.pub 2025-01-07 15:14:11.469301 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-07 15:14:11.469320 | ubuntu-noble -> localhost | SHA256:XU5GnfLbm4+HPv1HsPh6vmjdpncfZ6vl3pKpySKSA6c zuul-build-sshkey 2025-01-07 15:14:11.469338 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-07 15:14:11.469358 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-07 15:14:11.469376 | ubuntu-noble -> localhost | | .. . | 2025-01-07 15:14:11.469393 | ubuntu-noble -> localhost | | .. o | 2025-01-07 15:14:11.469409 | ubuntu-noble -> localhost | | +o | 2025-01-07 15:14:11.469426 | ubuntu-noble -> localhost | | . = o | 2025-01-07 15:14:11.469441 | ubuntu-noble -> localhost | | S . .. = | 2025-01-07 15:14:11.469457 | ubuntu-noble -> localhost | | . . . o o| 2025-01-07 15:14:11.469473 | ubuntu-noble -> localhost | | + . o X=| 2025-01-07 15:14:11.469488 | ubuntu-noble -> localhost | | E + . ...o%=&| 2025-01-07 15:14:11.469503 | ubuntu-noble -> localhost | | o . o*BO%@| 2025-01-07 15:14:11.469518 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-07 15:14:11.469555 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.454952 2025-01-07 15:14:11.475912 | 2025-01-07 15:14:11.475999 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-07 15:14:11.524729 | ubuntu-noble | ok 2025-01-07 15:14:11.562060 | ubuntu-noble | included: /var/lib/zuul/builds/b085d70affb948d88a1aaba1ab694af4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-07 15:14:11.575542 | 2025-01-07 15:14:11.575649 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-07 15:14:11.612640 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:11.621152 | 2025-01-07 15:14:11.621242 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-07 15:14:12.434039 | ubuntu-noble | changed 2025-01-07 15:14:12.452246 | 2025-01-07 15:14:12.452339 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-07 15:14:12.848487 | ubuntu-noble | ok 2025-01-07 15:14:12.855410 | 2025-01-07 15:14:12.855508 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-07 15:14:13.591524 | ubuntu-noble | changed 2025-01-07 15:14:13.598874 | 2025-01-07 15:14:13.598973 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-07 15:14:14.332322 | ubuntu-noble | changed 2025-01-07 15:14:14.352900 | 2025-01-07 15:14:14.353066 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-07 15:14:14.379371 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:14.396552 | 2025-01-07 15:14:14.396723 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-07 15:14:14.860053 | ubuntu-noble -> localhost | changed 2025-01-07 15:14:14.965455 | 2025-01-07 15:14:14.965581 | TASK [add-build-sshkey : Add back temp key] 2025-01-07 15:14:15.491385 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b085d70affb948d88a1aaba1ab694af4/work/b085d70affb948d88a1aaba1ab694af4_id_rsa (zuul-build-sshkey) 2025-01-07 15:14:15.491734 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016568 2025-01-07 15:14:15.499775 | 2025-01-07 15:14:15.499875 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-07 15:14:15.924082 | ubuntu-noble | ok 2025-01-07 15:14:15.938771 | 2025-01-07 15:14:15.938876 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-07 15:14:16.014416 | ubuntu-noble | skipping: Conditional result was False 2025-01-07 15:14:16.044058 | 2025-01-07 15:14:16.044258 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-07 15:14:16.708989 | ubuntu-noble | ok 2025-01-07 15:14:16.727956 | 2025-01-07 15:14:16.728062 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-07 15:14:16.800899 | ubuntu-noble | ok 2025-01-07 15:14:16.810924 | 2025-01-07 15:14:16.811018 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-07 15:14:17.226063 | ubuntu-noble -> localhost | ok 2025-01-07 15:14:17.242375 | 2025-01-07 15:14:17.242477 | TASK [validate-host : Collect information about the host] 2025-01-07 15:14:18.596542 | ubuntu-noble | ok 2025-01-07 15:14:18.622589 | 2025-01-07 15:14:18.622705 | TASK [validate-host : Sanitize hostname] 2025-01-07 15:14:18.732830 | ubuntu-noble | ok 2025-01-07 15:14:18.737998 | 2025-01-07 15:14:18.738078 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-07 15:14:20.117771 | ubuntu-noble -> localhost | changed 2025-01-07 15:14:20.123589 | 2025-01-07 15:14:20.123703 | TASK [validate-host : Collect information about zuul worker] 2025-01-07 15:14:20.629316 | ubuntu-noble | ok 2025-01-07 15:14:20.634595 | 2025-01-07 15:14:20.634696 | TASK [validate-host : Write out all zuul information for each host] 2025-01-07 15:14:21.483588 | ubuntu-noble -> localhost | changed 2025-01-07 15:14:21.502490 | 2025-01-07 15:14:21.502647 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-07 15:14:21.839727 | ubuntu-noble | ok 2025-01-07 15:14:21.845806 | 2025-01-07 15:14:21.845886 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-07 15:14:23.043227 | ubuntu-noble | changed: 2025-01-07 15:14:23.043387 | ubuntu-noble | cd+++++++++ src/ 2025-01-07 15:14:23.043414 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-07 15:14:23.043433 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-07 15:14:23.043451 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-07 15:14:23.043467 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-07 15:15:25.987173 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-07 15:15:26.011820 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-07 15:15:26.031851 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-07 15:15:26.054849 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-07 15:15:26.080140 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-07 15:15:26.384133 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-07 15:15:26.516111 | 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-07 15:15:31.033916 | ubuntu-noble | Installing missing stub packages: 2025-01-07 15:15:31.054100 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-07 15:15:31.054375 | ubuntu-noble | 2025-01-07 15:15:31.054388 | ubuntu-noble | 2025-01-07 15:15:31.054393 | ubuntu-noble | Success: no issues found in 11 source files 2025-01-07 15:15:31.161549 | ubuntu-noble | ok 2025-01-07 15:15:31.205754 | 2025-01-07 15:15:31.205862 | PLAY RECAP 2025-01-07 15:15:31.205954 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-07 15:15:31.205983 | 2025-01-07 15:15:31.335900 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-07 15:15:31.342060 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-07 15:15:32.050869 | 2025-01-07 15:15:32.051022 | PLAY [Base post] 2025-01-07 15:15:32.085043 | 2025-01-07 15:15:32.085192 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-07 15:15:32.708512 | ubuntu-noble | changed 2025-01-07 15:15:32.745835 | 2025-01-07 15:15:32.746016 | PLAY RECAP 2025-01-07 15:15:32.746099 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-07 15:15:32.746174 | 2025-01-07 15:15:32.899290 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-07 15:15:32.904866 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-07 15:15:33.671306 | 2025-01-07 15:15:33.671475 | PLAY [Base post-logs] 2025-01-07 15:15:33.687852 | 2025-01-07 15:15:33.687987 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-07 15:15:34.154992 | localhost | changed 2025-01-07 15:15:34.158967 | 2025-01-07 15:15:34.159100 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-07 15:15:34.186386 | localhost | ok 2025-01-07 15:15:34.192105 | 2025-01-07 15:15:34.192206 | TASK [Set zuul-log-path fact] 2025-01-07 15:15:34.210142 | localhost | ok 2025-01-07 15:15:34.238102 | 2025-01-07 15:15:34.238268 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-07 15:15:34.279971 | localhost | ok 2025-01-07 15:15:34.285382 | 2025-01-07 15:15:34.285531 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-07 15:15:34.321310 | localhost | skipping: Conditional result was False 2025-01-07 15:15:34.329980 | 2025-01-07 15:15:34.330167 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-07 15:15:34.371660 | localhost | skipping: Conditional result was False 2025-01-07 15:15:34.381809 | 2025-01-07 15:15:34.381958 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-07 15:15:34.408072 | localhost | skipping: Conditional result was False 2025-01-07 15:15:34.416840 | 2025-01-07 15:15:34.417028 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-07 15:15:34.443490 | localhost | skipping: Conditional result was False 2025-01-07 15:15:34.450929 | 2025-01-07 15:15:34.451100 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-07 15:15:34.479344 | localhost | skipping: Conditional result was False 2025-01-07 15:15:34.491810 | 2025-01-07 15:15:34.491967 | TASK [upload-logs : Create log directories] 2025-01-07 15:15:35.012030 | localhost | changed 2025-01-07 15:15:35.020816 | 2025-01-07 15:15:35.020983 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-07 15:15:35.579223 | localhost -> localhost | ok: Runtime: 0:00:00.007020 2025-01-07 15:15:35.591538 | 2025-01-07 15:15:35.591727 | TASK [upload-logs : Upload logs to log server] 2025-01-07 15:15:36.184743 | localhost | Output suppressed because no_log was given 2025-01-07 15:15:36.188012 | 2025-01-07 15:15:36.188118 | LOOP [upload-logs : Compress console log and json output] 2025-01-07 15:15:36.260815 | localhost | skipping: Conditional result was False 2025-01-07 15:15:36.278244 | localhost | skipping: Conditional result was False 2025-01-07 15:15:36.293573 | 2025-01-07 15:15:36.293814 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-07 15:15:36.361061 | localhost | skipping: Conditional result was False 2025-01-07 15:15:36.361749 | 2025-01-07 15:15:36.372744 | localhost | skipping: Conditional result was False 2025-01-07 15:15:36.393206 | 2025-01-07 15:15:36.393430 | LOOP [upload-logs : Upload console log and json output]