2025-01-21 22:13:17.430510 | Job console starting... 2025-01-21 22:13:17.459042 | Updating repositories 2025-01-21 22:13:17.506888 | Preparing job workspace 2025-01-21 22:13:19.336418 | Running Ansible setup... 2025-01-21 22:13:24.861996 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-21 22:13:25.598455 | 2025-01-21 22:13:25.598658 | PLAY [Base pre] 2025-01-21 22:13:25.628839 | 2025-01-21 22:13:25.628989 | TASK [Setup log path fact] 2025-01-21 22:13:25.666005 | ubuntu-noble | ok 2025-01-21 22:13:25.688316 | 2025-01-21 22:13:25.688491 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:13:25.761402 | ubuntu-noble | ok 2025-01-21 22:13:25.768127 | 2025-01-21 22:13:25.768250 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:13:25.803043 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:25.810503 | 2025-01-21 22:13:25.810641 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:13:25.871016 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:25.887882 | 2025-01-21 22:13:25.888016 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:13:25.912492 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:25.920028 | 2025-01-21 22:13:25.920152 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:13:25.944757 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:25.960429 | 2025-01-21 22:13:25.960574 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:13:25.984839 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:26.006010 | 2025-01-21 22:13:26.006155 | TASK [emit-job-header : Print job information] 2025-01-21 22:13:26.087235 | # Job Information 2025-01-21 22:13:26.087414 | Ansible Version: 2.15.3 2025-01-21 22:13:26.087446 | Job: openstack-project-manager-mypy 2025-01-21 22:13:26.087475 | Pipeline: check 2025-01-21 22:13:26.087495 | Executor: 7d211f194f6a 2025-01-21 22:13:26.087513 | Triggered by: https://github.com/osism/openstack-project-manager/pull/212 2025-01-21 22:13:26.087545 | Event ID: e4d49ed0-d844-11ef-8ecf-a73350ea066d 2025-01-21 22:13:26.094122 | 2025-01-21 22:13:26.094235 | LOOP [emit-job-header : Print node information] 2025-01-21 22:13:26.305949 | ubuntu-noble | ok: 2025-01-21 22:13:26.306157 | ubuntu-noble | # Node Information 2025-01-21 22:13:26.306203 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-21 22:13:26.306376 | ubuntu-noble | Hostname: ubuntu 2025-01-21 22:13:26.306402 | ubuntu-noble | Username: zuul 2025-01-21 22:13:26.306423 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-21 22:13:26.306443 | ubuntu-noble | Provider: regiocloud-a 2025-01-21 22:13:26.306462 | ubuntu-noble | Label: ubuntu-noble 2025-01-21 22:13:26.306481 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-21 22:13:26.306502 | ubuntu-noble | Interface IP: 81.163.193.191 2025-01-21 22:13:26.341101 | 2025-01-21 22:13:26.341242 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-21 22:13:26.894409 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:26.903020 | 2025-01-21 22:13:26.903151 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-21 22:13:27.976899 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:27.990813 | 2025-01-21 22:13:27.990935 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-21 22:13:28.283085 | ubuntu-noble -> localhost | ok 2025-01-21 22:13:28.291366 | 2025-01-21 22:13:28.291485 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-21 22:13:28.323165 | ubuntu-noble | ok 2025-01-21 22:13:28.348123 | ubuntu-noble | included: /var/lib/zuul/builds/a0f40a5619ea4bb29ac95d6203451abc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-21 22:13:28.355925 | 2025-01-21 22:13:28.356032 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-21 22:13:29.425219 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-21 22:13:29.425452 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a0f40a5619ea4bb29ac95d6203451abc/work/a0f40a5619ea4bb29ac95d6203451abc_id_rsa 2025-01-21 22:13:29.425494 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a0f40a5619ea4bb29ac95d6203451abc/work/a0f40a5619ea4bb29ac95d6203451abc_id_rsa.pub 2025-01-21 22:13:29.425521 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-21 22:13:29.425568 | ubuntu-noble -> localhost | SHA256:nspejPOsFL6IJYR672AJn/wUFcln1r5H/y9+4JzJwdw zuul-build-sshkey 2025-01-21 22:13:29.425592 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-21 22:13:29.425618 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-21 22:13:29.425641 | ubuntu-noble -> localhost | | ... . | 2025-01-21 22:13:29.425662 | ubuntu-noble -> localhost | | o.+ . | 2025-01-21 22:13:29.425682 | ubuntu-noble -> localhost | | .+ . | 2025-01-21 22:13:29.425702 | ubuntu-noble -> localhost | | . . . . | 2025-01-21 22:13:29.425722 | ubuntu-noble -> localhost | |o . . . S o + . | 2025-01-21 22:13:29.428094 | ubuntu-noble -> localhost | |.= o o = .. . * E| 2025-01-21 22:13:29.428154 | ubuntu-noble -> localhost | |. X o = = . + * | 2025-01-21 22:13:29.428180 | ubuntu-noble -> localhost | | o O + B B o| 2025-01-21 22:13:29.428204 | ubuntu-noble -> localhost | | ..=.*.o ..oo| 2025-01-21 22:13:29.428225 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-21 22:13:29.428296 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.216409 2025-01-21 22:13:29.447706 | 2025-01-21 22:13:29.447827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-21 22:13:29.541995 | ubuntu-noble | ok 2025-01-21 22:13:29.562271 | ubuntu-noble | included: /var/lib/zuul/builds/a0f40a5619ea4bb29ac95d6203451abc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-21 22:13:29.578090 | 2025-01-21 22:13:29.578218 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-21 22:13:29.614950 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:29.624601 | 2025-01-21 22:13:29.624735 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-21 22:13:30.428520 | ubuntu-noble | changed 2025-01-21 22:13:30.437994 | 2025-01-21 22:13:30.438132 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-21 22:13:30.762223 | ubuntu-noble | ok 2025-01-21 22:13:30.769665 | 2025-01-21 22:13:30.769780 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-21 22:13:31.518120 | ubuntu-noble | changed 2025-01-21 22:13:31.529317 | 2025-01-21 22:13:31.530895 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-21 22:13:32.299255 | ubuntu-noble | changed 2025-01-21 22:13:32.307582 | 2025-01-21 22:13:32.307705 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-21 22:13:32.332517 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:32.341225 | 2025-01-21 22:13:32.341341 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-21 22:13:32.832338 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:32.847027 | 2025-01-21 22:13:32.847159 | TASK [add-build-sshkey : Add back temp key] 2025-01-21 22:13:33.252373 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a0f40a5619ea4bb29ac95d6203451abc/work/a0f40a5619ea4bb29ac95d6203451abc_id_rsa (zuul-build-sshkey) 2025-01-21 22:13:33.252882 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009073 2025-01-21 22:13:33.297241 | 2025-01-21 22:13:33.297374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-21 22:13:33.713816 | ubuntu-noble | ok 2025-01-21 22:13:33.725120 | 2025-01-21 22:13:33.725315 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-21 22:13:33.752299 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:33.781817 | 2025-01-21 22:13:33.781960 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-21 22:13:34.231872 | ubuntu-noble | ok 2025-01-21 22:13:34.246282 | 2025-01-21 22:13:34.246420 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-21 22:13:34.289593 | ubuntu-noble | ok 2025-01-21 22:13:34.299831 | 2025-01-21 22:13:34.300098 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-21 22:13:34.601836 | ubuntu-noble -> localhost | ok 2025-01-21 22:13:34.609804 | 2025-01-21 22:13:34.609928 | TASK [validate-host : Collect information about the host] 2025-01-21 22:13:35.893301 | ubuntu-noble | ok 2025-01-21 22:13:35.914021 | 2025-01-21 22:13:35.914166 | TASK [validate-host : Sanitize hostname] 2025-01-21 22:13:35.986399 | ubuntu-noble | ok 2025-01-21 22:13:35.993788 | 2025-01-21 22:13:35.993905 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-21 22:13:36.701501 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:36.710325 | 2025-01-21 22:13:36.710454 | TASK [validate-host : Collect information about zuul worker] 2025-01-21 22:13:37.382344 | ubuntu-noble | ok 2025-01-21 22:13:37.396643 | 2025-01-21 22:13:37.397075 | TASK [validate-host : Write out all zuul information for each host] 2025-01-21 22:13:38.145810 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:38.165337 | 2025-01-21 22:13:38.165567 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-21 22:13:38.522011 | ubuntu-noble | ok 2025-01-21 22:13:38.530397 | 2025-01-21 22:13:38.530547 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-21 22:13:39.475131 | ubuntu-noble | changed: 2025-01-21 22:13:39.475439 | ubuntu-noble | cd+++++++++ src/ 2025-01-21 22:13:39.475503 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-21 22:13:39.475576 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-21 22:13:39.475619 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-01-21 22:13:39.475657 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-21 22:15:02.195043 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-21 22:15:02.221813 | ubuntu-noble | Downloading types_decorator-5.1.8.20250121-py3-none-any.whl (8.1 kB) 2025-01-21 22:15:02.243721 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-21 22:15:02.265456 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-21 22:15:02.286203 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-21 22:15:02.612743 | ubuntu-noble | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML, types-decorator 2025-01-21 22:15:02.727513 | 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-21 22:15:08.191812 | ubuntu-noble | Installing missing stub packages: 2025-01-21 22:15:08.207828 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson types-tabulate 2025-01-21 22:15:08.208085 | ubuntu-noble | 2025-01-21 22:15:08.208118 | ubuntu-noble | 2025-01-21 22:15:08.208143 | ubuntu-noble | Success: no issues found in 13 source files 2025-01-21 22:15:08.274769 | ubuntu-noble | ok 2025-01-21 22:15:08.339488 | 2025-01-21 22:15:08.339637 | PLAY RECAP 2025-01-21 22:15:08.339709 | ubuntu-noble | ok: 11 changed: 6 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-21 22:15:08.339742 | 2025-01-21 22:15:08.473866 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-21 22:15:08.479299 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-21 22:15:09.213209 | 2025-01-21 22:15:09.213374 | PLAY [Base post] 2025-01-21 22:15:09.239470 | 2025-01-21 22:15:09.239623 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-21 22:15:09.875714 | ubuntu-noble | changed 2025-01-21 22:15:09.912595 | 2025-01-21 22:15:09.912738 | PLAY RECAP 2025-01-21 22:15:09.912803 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-21 22:15:09.912865 | 2025-01-21 22:15:10.030131 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-21 22:15:10.033041 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-21 22:15:10.825661 | 2025-01-21 22:15:10.825834 | PLAY [Base post-logs] 2025-01-21 22:15:10.842301 | 2025-01-21 22:15:10.842447 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-21 22:15:11.277501 | localhost | changed 2025-01-21 22:15:11.281266 | 2025-01-21 22:15:11.281396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-21 22:15:11.319440 | localhost | ok 2025-01-21 22:15:11.326143 | 2025-01-21 22:15:11.326252 | TASK [Set zuul-log-path fact] 2025-01-21 22:15:11.344555 | localhost | ok 2025-01-21 22:15:11.357948 | 2025-01-21 22:15:11.358060 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:15:11.397241 | localhost | ok 2025-01-21 22:15:11.401764 | 2025-01-21 22:15:11.401911 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:15:11.437517 | localhost | skipping: Conditional result was False 2025-01-21 22:15:11.445820 | 2025-01-21 22:15:11.446005 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:15:11.487777 | localhost | skipping: Conditional result was False 2025-01-21 22:15:11.496745 | 2025-01-21 22:15:11.496929 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:15:11.523269 | localhost | skipping: Conditional result was False 2025-01-21 22:15:11.530331 | 2025-01-21 22:15:11.530495 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:15:11.556228 | localhost | skipping: Conditional result was False 2025-01-21 22:15:11.562152 | 2025-01-21 22:15:11.562302 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:15:11.588870 | localhost | skipping: Conditional result was False 2025-01-21 22:15:11.602794 | 2025-01-21 22:15:11.602968 | TASK [upload-logs : Create log directories] 2025-01-21 22:15:12.132215 | localhost | changed 2025-01-21 22:15:12.137205 | 2025-01-21 22:15:12.137313 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-21 22:15:12.677821 | localhost -> localhost | ok: Runtime: 0:00:00.007730 2025-01-21 22:15:12.689444 | 2025-01-21 22:15:12.689649 | TASK [upload-logs : Upload logs to log server] 2025-01-21 22:15:13.246371 | localhost | Output suppressed because no_log was given 2025-01-21 22:15:13.249626 | 2025-01-21 22:15:13.249735 | LOOP [upload-logs : Compress console log and json output] 2025-01-21 22:15:13.320637 | localhost | skipping: Conditional result was False 2025-01-21 22:15:13.337164 | localhost | skipping: Conditional result was False 2025-01-21 22:15:13.355199 | 2025-01-21 22:15:13.355394 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-21 22:15:13.438191 | localhost | skipping: Conditional result was False 2025-01-21 22:15:13.438503 | 2025-01-21 22:15:13.453515 | localhost | skipping: Conditional result was False 2025-01-21 22:15:13.459627 | 2025-01-21 22:15:13.459747 | LOOP [upload-logs : Upload console log and json output]