2025-03-05 02:54:37.436375 | Job console starting... 2025-03-05 02:54:37.468915 | Updating repositories 2025-03-05 02:54:37.509233 | Preparing job workspace 2025-03-05 02:54:40.149904 | Running Ansible setup... 2025-03-05 02:54:46.380071 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-05 02:54:47.408905 | 2025-03-05 02:54:47.409037 | PLAY [Base pre] 2025-03-05 02:54:47.444721 | 2025-03-05 02:54:47.444838 | TASK [Setup log path fact] 2025-03-05 02:54:47.472848 | ubuntu-noble | ok 2025-03-05 02:54:47.518992 | 2025-03-05 02:54:47.519121 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 02:54:47.570536 | ubuntu-noble | ok 2025-03-05 02:54:47.576994 | 2025-03-05 02:54:47.577084 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 02:54:47.610794 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:47.617653 | 2025-03-05 02:54:47.617754 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 02:54:47.672739 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:47.687393 | 2025-03-05 02:54:47.687500 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 02:54:47.731432 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:47.737364 | 2025-03-05 02:54:47.737449 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 02:54:47.751137 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:47.757829 | 2025-03-05 02:54:47.757926 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 02:54:47.807065 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:47.821394 | 2025-03-05 02:54:47.821492 | TASK [emit-job-header : Print job information] 2025-03-05 02:54:47.886680 | # Job Information 2025-03-05 02:54:47.886823 | Ansible Version: 2.15.3 2025-03-05 02:54:47.886850 | Job: mypy 2025-03-05 02:54:47.886874 | Pipeline: check 2025-03-05 02:54:47.886890 | Executor: 7d211f194f6a 2025-03-05 02:54:47.886905 | Triggered by: https://github.com/osism/python-osism/pull/1215 2025-03-05 02:54:47.886920 | Event ID: 286e3f40-f96d-11ef-835f-f320ed0f9ace 2025-03-05 02:54:47.892113 | 2025-03-05 02:54:47.892206 | LOOP [emit-job-header : Print node information] 2025-03-05 02:54:48.066263 | ubuntu-noble | ok: 2025-03-05 02:54:48.066420 | ubuntu-noble | # Node Information 2025-03-05 02:54:48.066453 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-05 02:54:48.066477 | ubuntu-noble | Hostname: ubuntu 2025-03-05 02:54:48.066498 | ubuntu-noble | Username: zuul 2025-03-05 02:54:48.066518 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-05 02:54:48.066812 | ubuntu-noble | Provider: regiocloud-a 2025-03-05 02:54:48.066858 | ubuntu-noble | Label: ubuntu-noble 2025-03-05 02:54:48.066880 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-05 02:54:48.066901 | ubuntu-noble | Interface IP: 81.163.193.8 2025-03-05 02:54:48.086703 | 2025-03-05 02:54:48.086799 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-05 02:54:48.725372 | ubuntu-noble -> localhost | changed 2025-03-05 02:54:48.731844 | 2025-03-05 02:54:48.731927 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-05 02:54:50.118978 | ubuntu-noble -> localhost | changed 2025-03-05 02:54:50.134564 | 2025-03-05 02:54:50.134668 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-05 02:54:50.598084 | ubuntu-noble -> localhost | ok 2025-03-05 02:54:50.605324 | 2025-03-05 02:54:50.605424 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-05 02:54:50.635023 | ubuntu-noble | ok 2025-03-05 02:54:50.666537 | ubuntu-noble | included: /var/lib/zuul/builds/b0a38da33ac14fee98f33106bd5fbaae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-05 02:54:50.674108 | 2025-03-05 02:54:50.674218 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-05 02:54:51.315714 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-05 02:54:51.315904 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b0a38da33ac14fee98f33106bd5fbaae/work/b0a38da33ac14fee98f33106bd5fbaae_id_rsa 2025-03-05 02:54:51.315943 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b0a38da33ac14fee98f33106bd5fbaae/work/b0a38da33ac14fee98f33106bd5fbaae_id_rsa.pub 2025-03-05 02:54:51.315968 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-05 02:54:51.315992 | ubuntu-noble -> localhost | SHA256:Mi/k3PAVpd7Plc8bEaxz2MyKaG12ktOb5eOtonfCkYc zuul-build-sshkey 2025-03-05 02:54:51.316014 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-05 02:54:51.316038 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-05 02:54:51.316060 | ubuntu-noble -> localhost | | . | 2025-03-05 02:54:51.316080 | ubuntu-noble -> localhost | | o . | 2025-03-05 02:54:51.316099 | ubuntu-noble -> localhost | | o o | 2025-03-05 02:54:51.316119 | ubuntu-noble -> localhost | | . o * o| 2025-03-05 02:54:51.316138 | ubuntu-noble -> localhost | | = S o .* B.| 2025-03-05 02:54:51.316157 | ubuntu-noble -> localhost | | + B .o Eo=oo| 2025-03-05 02:54:51.316175 | ubuntu-noble -> localhost | | + +o X *ooo| 2025-03-05 02:54:51.316208 | ubuntu-noble -> localhost | | .. o O *.+| 2025-03-05 02:54:51.316228 | ubuntu-noble -> localhost | | .o *o=o| 2025-03-05 02:54:51.316248 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-05 02:54:51.316293 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.150224 2025-03-05 02:54:51.324419 | 2025-03-05 02:54:51.324507 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-05 02:54:51.353755 | ubuntu-noble | ok 2025-03-05 02:54:51.375771 | ubuntu-noble | included: /var/lib/zuul/builds/b0a38da33ac14fee98f33106bd5fbaae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-05 02:54:51.385203 | 2025-03-05 02:54:51.385291 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-05 02:54:51.410829 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:51.417739 | 2025-03-05 02:54:51.417824 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-05 02:54:52.275930 | ubuntu-noble | changed 2025-03-05 02:54:52.285076 | 2025-03-05 02:54:52.285244 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-05 02:54:52.639107 | ubuntu-noble | ok 2025-03-05 02:54:52.644919 | 2025-03-05 02:54:52.644995 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-05 02:54:53.441630 | ubuntu-noble | changed 2025-03-05 02:54:53.448544 | 2025-03-05 02:54:53.448637 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-05 02:54:54.159958 | ubuntu-noble | changed 2025-03-05 02:54:54.166613 | 2025-03-05 02:54:54.166703 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-05 02:54:54.201027 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:54.207176 | 2025-03-05 02:54:54.207287 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-05 02:54:54.627034 | ubuntu-noble -> localhost | changed 2025-03-05 02:54:54.641169 | 2025-03-05 02:54:54.641278 | TASK [add-build-sshkey : Add back temp key] 2025-03-05 02:54:55.060267 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b0a38da33ac14fee98f33106bd5fbaae/work/b0a38da33ac14fee98f33106bd5fbaae_id_rsa (zuul-build-sshkey) 2025-03-05 02:54:55.060532 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008015 2025-03-05 02:54:55.091519 | 2025-03-05 02:54:55.091621 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-05 02:54:55.583925 | ubuntu-noble | ok 2025-03-05 02:54:55.592573 | 2025-03-05 02:54:55.592683 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-05 02:54:55.616618 | ubuntu-noble | skipping: Conditional result was False 2025-03-05 02:54:55.629373 | 2025-03-05 02:54:55.629483 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-05 02:54:56.099298 | ubuntu-noble | ok 2025-03-05 02:54:56.115037 | 2025-03-05 02:54:56.115130 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-05 02:54:56.158872 | ubuntu-noble | ok 2025-03-05 02:54:56.166858 | 2025-03-05 02:54:56.166950 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-05 02:54:56.445593 | ubuntu-noble -> localhost | ok 2025-03-05 02:54:56.453164 | 2025-03-05 02:54:56.453260 | TASK [validate-host : Collect information about the host] 2025-03-05 02:54:57.731245 | ubuntu-noble | ok 2025-03-05 02:54:57.744310 | 2025-03-05 02:54:57.744494 | TASK [validate-host : Sanitize hostname] 2025-03-05 02:54:57.804837 | ubuntu-noble | ok 2025-03-05 02:54:57.810663 | 2025-03-05 02:54:57.810752 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-05 02:54:58.608482 | ubuntu-noble -> localhost | changed 2025-03-05 02:54:58.615623 | 2025-03-05 02:54:58.615718 | TASK [validate-host : Collect information about zuul worker] 2025-03-05 02:54:59.150044 | ubuntu-noble | ok 2025-03-05 02:54:59.156225 | 2025-03-05 02:54:59.156311 | TASK [validate-host : Write out all zuul information for each host] 2025-03-05 02:54:59.688003 | ubuntu-noble -> localhost | changed 2025-03-05 02:54:59.700287 | 2025-03-05 02:54:59.700425 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-05 02:55:00.053275 | ubuntu-noble | ok 2025-03-05 02:55:00.067824 | 2025-03-05 02:55:00.067967 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-05 02:55:01.478319 | ubuntu-noble | changed: 2025-03-05 02:55:01.478521 | ubuntu-noble | cd+++++++++ src/ 2025-03-05 02:55:01.478554 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-05 02:55:01.478577 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-05 02:55:01.478599 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-05 02:55:01.478619 | ubuntu-noble | Containerfile 2025-03-05 02:55:01.478733 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-05 02:57:02.913395 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-05 02:57:02.945330 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-05 02:57:02.983149 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-03-05 02:57:03.012461 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250204-py3-none-any.whl (10 kB) 2025-03-05 02:57:03.040849 | ubuntu-noble | Downloading types_requests-2.32.0.20250301-py3-none-any.whl (20 kB) 2025-03-05 02:57:03.074122 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-03-05 02:57:03.101091 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-05 02:57:03.130957 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-03-05 02:57:03.944437 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator 2025-03-05 02:57:04.346229 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.2.0.20250224 types-python-dateutil-2.9.0.20241206 types-pytz-2025.1.0.20250204 types-requests-2.32.0.20250301 types-simplejson-3.20.0.20250218 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-03-05 02:57:16.458709 | ubuntu-noble | Installing missing stub packages: 2025-03-05 02:57:16.488054 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-03-05 02:57:16.488124 | ubuntu-noble | 2025-03-05 02:57:16.488130 | ubuntu-noble | 2025-03-05 02:57:16.488135 | ubuntu-noble | Success: no issues found in 55 source files 2025-03-05 02:57:16.747411 | ubuntu-noble | ok 2025-03-05 02:57:16.821599 | 2025-03-05 02:57:16.821721 | PLAY RECAP 2025-03-05 02:57:16.821777 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-05 02:57:16.821804 | 2025-03-05 02:57:16.934609 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-05 02:57:16.937266 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-05 02:57:17.625866 | 2025-03-05 02:57:17.626021 | PLAY [Base post] 2025-03-05 02:57:17.651922 | 2025-03-05 02:57:17.652049 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-05 02:57:18.344766 | ubuntu-noble | changed 2025-03-05 02:57:18.382451 | 2025-03-05 02:57:18.382584 | PLAY RECAP 2025-03-05 02:57:18.382658 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-05 02:57:18.382723 | 2025-03-05 02:57:18.495637 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-05 02:57:18.498179 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-05 02:57:19.298648 | 2025-03-05 02:57:19.298811 | PLAY [Base post-logs] 2025-03-05 02:57:19.315202 | 2025-03-05 02:57:19.315367 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-05 02:57:19.780440 | localhost | changed 2025-03-05 02:57:19.786815 | 2025-03-05 02:57:19.786981 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-05 02:57:19.817065 | localhost | ok 2025-03-05 02:57:19.826645 | 2025-03-05 02:57:19.826786 | TASK [Set zuul-log-path fact] 2025-03-05 02:57:19.846313 | localhost | ok 2025-03-05 02:57:19.863999 | 2025-03-05 02:57:19.864109 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 02:57:19.910954 | localhost | ok 2025-03-05 02:57:19.914189 | 2025-03-05 02:57:19.914311 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 02:57:19.948276 | localhost | skipping: Conditional result was False 2025-03-05 02:57:19.951675 | 2025-03-05 02:57:19.951886 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 02:57:19.989414 | localhost | skipping: Conditional result was False 2025-03-05 02:57:19.997595 | 2025-03-05 02:57:19.997812 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-05 02:57:20.024059 | localhost | skipping: Conditional result was False 2025-03-05 02:57:20.032246 | 2025-03-05 02:57:20.032564 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-05 02:57:20.059110 | localhost | skipping: Conditional result was False 2025-03-05 02:57:20.066595 | 2025-03-05 02:57:20.066771 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-05 02:57:20.103574 | localhost | skipping: Conditional result was False 2025-03-05 02:57:20.116910 | 2025-03-05 02:57:20.117066 | TASK [upload-logs : Create log directories] 2025-03-05 02:57:20.644827 | localhost | changed 2025-03-05 02:57:20.649595 | 2025-03-05 02:57:20.649702 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-05 02:57:21.155347 | localhost -> localhost | ok: Runtime: 0:00:00.005651 2025-03-05 02:57:21.166515 | 2025-03-05 02:57:21.166677 | TASK [upload-logs : Upload logs to log server] 2025-03-05 02:57:21.733055 | localhost | Output suppressed because no_log was given 2025-03-05 02:57:21.739542 | 2025-03-05 02:57:21.739701 | LOOP [upload-logs : Compress console log and json output] 2025-03-05 02:57:21.817622 | localhost | skipping: Conditional result was False 2025-03-05 02:57:21.834602 | localhost | skipping: Conditional result was False 2025-03-05 02:57:21.849006 | 2025-03-05 02:57:21.849231 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-05 02:57:21.913326 | localhost | skipping: Conditional result was False 2025-03-05 02:57:21.913922 | 2025-03-05 02:57:21.925742 | localhost | skipping: Conditional result was False 2025-03-05 02:57:21.938319 | 2025-03-05 02:57:21.938494 | LOOP [upload-logs : Upload console log and json output]