2025-01-08 11:22:11.406988 | Job console starting... 2025-01-08 11:22:11.447302 | Updating repositories 2025-01-08 11:22:11.494742 | Preparing job workspace 2025-01-08 11:22:13.849690 | Running Ansible setup... 2025-01-08 11:22:22.428512 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 11:22:23.558300 | 2025-01-08 11:22:23.558429 | PLAY [Base pre] 2025-01-08 11:22:23.608082 | 2025-01-08 11:22:23.608210 | TASK [Setup log path fact] 2025-01-08 11:22:23.662860 | ubuntu-noble | ok 2025-01-08 11:22:23.701286 | 2025-01-08 11:22:23.701418 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:22:23.828062 | ubuntu-noble | ok 2025-01-08 11:22:23.842685 | 2025-01-08 11:22:23.842789 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:22:23.911285 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:23.918484 | 2025-01-08 11:22:23.918589 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:22:24.004073 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:24.011413 | 2025-01-08 11:22:24.011528 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:22:24.100139 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:24.107594 | 2025-01-08 11:22:24.107702 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:22:24.145802 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:24.154258 | 2025-01-08 11:22:24.154367 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:22:24.188332 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:24.205851 | 2025-01-08 11:22:24.209790 | TASK [emit-job-header : Print job information] 2025-01-08 11:22:24.319795 | # Job Information 2025-01-08 11:22:24.319950 | Ansible Version: 2.15.3 2025-01-08 11:22:24.319981 | Job: mypy 2025-01-08 11:22:24.320006 | Pipeline: check 2025-01-08 11:22:24.320023 | Executor: 7d211f194f6a 2025-01-08 11:22:24.320037 | Triggered by: https://github.com/osism/openstack-image-manager/pull/866 2025-01-08 11:22:24.320052 | Event ID: c9496d40-cdb2-11ef-9bae-8a10bdacf6d7 2025-01-08 11:22:24.346276 | 2025-01-08 11:22:24.346411 | LOOP [emit-job-header : Print node information] 2025-01-08 11:22:24.575582 | ubuntu-noble | ok: 2025-01-08 11:22:24.575769 | ubuntu-noble | # Node Information 2025-01-08 11:22:24.575802 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 11:22:24.575826 | ubuntu-noble | Hostname: ubuntu 2025-01-08 11:22:24.575847 | ubuntu-noble | Username: zuul 2025-01-08 11:22:24.575867 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 11:22:24.575887 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 11:22:24.575906 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 11:22:24.575925 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 11:22:24.575946 | ubuntu-noble | Interface IP: 81.163.192.249 2025-01-08 11:22:24.599826 | 2025-01-08 11:22:24.599924 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 11:22:25.391778 | ubuntu-noble -> localhost | changed 2025-01-08 11:22:25.398821 | 2025-01-08 11:22:25.398909 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 11:22:26.851509 | ubuntu-noble -> localhost | changed 2025-01-08 11:22:26.876203 | 2025-01-08 11:22:26.876307 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 11:22:27.398095 | ubuntu-noble -> localhost | ok 2025-01-08 11:22:27.406528 | 2025-01-08 11:22:27.406617 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 11:22:27.456266 | ubuntu-noble | ok 2025-01-08 11:22:27.482371 | ubuntu-noble | included: /var/lib/zuul/builds/cf2d213691474d9d92cbab3a2563bc9f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 11:22:27.497274 | 2025-01-08 11:22:27.502057 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 11:22:28.578409 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 11:22:28.578620 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/cf2d213691474d9d92cbab3a2563bc9f/work/cf2d213691474d9d92cbab3a2563bc9f_id_rsa 2025-01-08 11:22:28.578653 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/cf2d213691474d9d92cbab3a2563bc9f/work/cf2d213691474d9d92cbab3a2563bc9f_id_rsa.pub 2025-01-08 11:22:28.578674 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 11:22:28.578692 | ubuntu-noble -> localhost | SHA256:G+dd6+Iw2tOT36OwS1as5BYj4WuLrOVPTMpZIzeAw8M zuul-build-sshkey 2025-01-08 11:22:28.578710 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 11:22:28.578730 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 11:22:28.578748 | ubuntu-noble -> localhost | | | 2025-01-08 11:22:28.578764 | ubuntu-noble -> localhost | | o . | 2025-01-08 11:22:28.578780 | ubuntu-noble -> localhost | | E . . | 2025-01-08 11:22:28.578796 | ubuntu-noble -> localhost | | o o . . | 2025-01-08 11:22:28.578811 | ubuntu-noble -> localhost | | .SO.+ o. | 2025-01-08 11:22:28.578826 | ubuntu-noble -> localhost | | . O=B.=. . | 2025-01-08 11:22:28.578842 | ubuntu-noble -> localhost | | =.=+O... | 2025-01-08 11:22:28.578858 | ubuntu-noble -> localhost | | + +o*oB. o | 2025-01-08 11:22:28.578874 | ubuntu-noble -> localhost | | ..+oo.=o=+ o| 2025-01-08 11:22:28.578890 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 11:22:28.578930 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.480560 2025-01-08 11:22:28.585172 | 2025-01-08 11:22:28.585249 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 11:22:28.633699 | ubuntu-noble | ok 2025-01-08 11:22:28.648837 | ubuntu-noble | included: /var/lib/zuul/builds/cf2d213691474d9d92cbab3a2563bc9f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 11:22:28.663239 | 2025-01-08 11:22:28.663314 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 11:22:28.702848 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:28.708811 | 2025-01-08 11:22:28.708889 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 11:22:29.742371 | ubuntu-noble | changed 2025-01-08 11:22:29.754654 | 2025-01-08 11:22:29.754745 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 11:22:30.101786 | ubuntu-noble | ok 2025-01-08 11:22:30.112706 | 2025-01-08 11:22:30.112789 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 11:22:30.908439 | ubuntu-noble | changed 2025-01-08 11:22:30.916822 | 2025-01-08 11:22:30.916919 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 11:22:31.638117 | ubuntu-noble | changed 2025-01-08 11:22:31.645048 | 2025-01-08 11:22:31.645143 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 11:22:31.680139 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:31.688675 | 2025-01-08 11:22:31.688778 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 11:22:32.188890 | ubuntu-noble -> localhost | changed 2025-01-08 11:22:32.236871 | 2025-01-08 11:22:32.236966 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 11:22:32.798732 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/cf2d213691474d9d92cbab3a2563bc9f/work/cf2d213691474d9d92cbab3a2563bc9f_id_rsa (zuul-build-sshkey) 2025-01-08 11:22:32.798932 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.029131 2025-01-08 11:22:32.822846 | 2025-01-08 11:22:32.822955 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 11:22:33.570741 | ubuntu-noble | ok 2025-01-08 11:22:33.580762 | 2025-01-08 11:22:33.580855 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 11:22:33.649876 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:22:33.671952 | 2025-01-08 11:22:33.672061 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 11:22:34.201274 | ubuntu-noble | ok 2025-01-08 11:22:34.244847 | 2025-01-08 11:22:34.244954 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 11:22:34.350063 | ubuntu-noble | ok 2025-01-08 11:22:34.359021 | 2025-01-08 11:22:34.359111 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 11:22:34.870888 | ubuntu-noble -> localhost | ok 2025-01-08 11:22:34.877402 | 2025-01-08 11:22:34.877491 | TASK [validate-host : Collect information about the host] 2025-01-08 11:22:36.171152 | ubuntu-noble | ok 2025-01-08 11:22:36.203680 | 2025-01-08 11:22:36.203807 | TASK [validate-host : Sanitize hostname] 2025-01-08 11:22:36.339176 | ubuntu-noble | ok 2025-01-08 11:22:36.356672 | 2025-01-08 11:22:36.356790 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 11:22:37.682320 | ubuntu-noble -> localhost | changed 2025-01-08 11:22:37.691015 | 2025-01-08 11:22:37.691099 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 11:22:38.227089 | ubuntu-noble | ok 2025-01-08 11:22:38.235396 | 2025-01-08 11:22:38.235515 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 11:22:39.342263 | ubuntu-noble -> localhost | changed 2025-01-08 11:22:39.361701 | 2025-01-08 11:22:39.361805 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 11:22:39.798217 | ubuntu-noble | ok 2025-01-08 11:22:39.805324 | 2025-01-08 11:22:39.805418 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 11:22:41.041815 | ubuntu-noble | changed: 2025-01-08 11:22:41.042234 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 11:22:41.042283 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 11:22:41.042307 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 11:22:41.042329 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 11:22:41.042349 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-08 11:23:48.670185 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-08 11:23:48.698876 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-08 11:23:48.726825 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-08 11:23:48.758989 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-08 11:23:48.786215 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-08 11:23:49.140747 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-08 11:23:49.288773 | 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:23:54.210546 | ubuntu-noble | Installing missing stub packages: 2025-01-08 11:23:54.233086 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-08 11:23:54.233194 | ubuntu-noble | 2025-01-08 11:23:54.233201 | ubuntu-noble | 2025-01-08 11:23:54.233218 | ubuntu-noble | Success: no issues found in 11 source files 2025-01-08 11:23:54.431769 | ubuntu-noble | ok 2025-01-08 11:23:54.490952 | 2025-01-08 11:23:54.491200 | PLAY RECAP 2025-01-08 11:23:54.491280 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-08 11:23:54.491308 | 2025-01-08 11:23:54.708940 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-08 11:23:54.711658 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:23:55.432355 | 2025-01-08 11:23:55.432465 | PLAY [Base post] 2025-01-08 11:23:55.463819 | 2025-01-08 11:23:55.463943 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-08 11:23:56.109381 | ubuntu-noble | changed 2025-01-08 11:23:56.162355 | 2025-01-08 11:23:56.162450 | PLAY RECAP 2025-01-08 11:23:56.162502 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-08 11:23:56.162553 | 2025-01-08 11:23:56.266553 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:23:56.268934 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-08 11:23:57.083826 | 2025-01-08 11:23:57.083945 | PLAY [Base post-logs] 2025-01-08 11:23:57.104485 | 2025-01-08 11:23:57.104592 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-08 11:23:57.698807 | localhost | changed 2025-01-08 11:23:57.701752 | 2025-01-08 11:23:57.701852 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-08 11:23:57.758983 | localhost | ok 2025-01-08 11:23:57.763567 | 2025-01-08 11:23:57.763664 | TASK [Set zuul-log-path fact] 2025-01-08 11:23:57.814288 | localhost | ok 2025-01-08 11:23:57.825424 | 2025-01-08 11:23:57.825523 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:23:57.927397 | localhost | ok 2025-01-08 11:23:57.932347 | 2025-01-08 11:23:57.932438 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:23:57.968503 | localhost | skipping: Conditional result was False 2025-01-08 11:23:57.971379 | 2025-01-08 11:23:57.972046 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:23:58.005456 | localhost | skipping: Conditional result was False 2025-01-08 11:23:58.008459 | 2025-01-08 11:23:58.008552 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:23:58.062638 | localhost | skipping: Conditional result was False 2025-01-08 11:23:58.067074 | 2025-01-08 11:23:58.067178 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:23:58.111175 | localhost | skipping: Conditional result was False 2025-01-08 11:23:58.114097 | 2025-01-08 11:23:58.114178 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:23:58.153504 | localhost | skipping: Conditional result was False 2025-01-08 11:23:58.159456 | 2025-01-08 11:23:58.159543 | TASK [upload-logs : Create log directories] 2025-01-08 11:23:58.591872 | localhost | changed 2025-01-08 11:23:58.595983 | 2025-01-08 11:23:58.596054 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-08 11:23:59.228351 | localhost -> localhost | ok: Runtime: 0:00:00.009320 2025-01-08 11:23:59.232530 | 2025-01-08 11:23:59.232604 | TASK [upload-logs : Upload logs to log server] 2025-01-08 11:24:00.265448 | localhost | Output suppressed because no_log was given 2025-01-08 11:24:00.279427 | 2025-01-08 11:24:00.279524 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 11:24:00.434085 | localhost | skipping: Conditional result was False 2025-01-08 11:24:00.451371 | localhost | skipping: Conditional result was False 2025-01-08 11:24:00.455115 | 2025-01-08 11:24:00.455216 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 11:24:00.517956 | localhost | skipping: Conditional result was False 2025-01-08 11:24:00.518199 | 2025-01-08 11:24:00.533372 | localhost | skipping: Conditional result was False 2025-01-08 11:24:00.542736 | 2025-01-08 11:24:00.542835 | LOOP [upload-logs : Upload console log and json output]