2026-05-18 09:43:58.708325 | Job console starting 2026-05-18 09:43:58.723646 | Updating git repos 2026-05-18 09:43:58.794353 | Cloning repos into workspace 2026-05-18 09:43:58.956821 | Restoring repo states 2026-05-18 09:43:58.985983 | Merging changes 2026-05-18 09:43:59.575137 | Checking out repos 2026-05-18 09:43:59.641446 | Preparing playbooks 2026-05-18 09:44:01.071892 | Running Ansible setup 2026-05-18 09:44:06.938441 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 09:44:08.062066 | 2026-05-18 09:44:08.062194 | PLAY [Base pre] 2026-05-18 09:44:08.098007 | 2026-05-18 09:44:08.098138 | TASK [Setup log path fact] 2026-05-18 09:44:08.127452 | debian-bookworm | ok 2026-05-18 09:44:08.177431 | 2026-05-18 09:44:08.177604 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:44:08.263713 | debian-bookworm | ok 2026-05-18 09:44:08.282025 | 2026-05-18 09:44:08.282155 | TASK [emit-job-header : Print job information] 2026-05-18 09:44:08.379777 | # Job Information 2026-05-18 09:44:08.379981 | Ansible Version: 2.16.14 2026-05-18 09:44:08.380017 | Job: mypy 2026-05-18 09:44:08.380050 | Pipeline: check 2026-05-18 09:44:08.380073 | Executor: 521e9411259a 2026-05-18 09:44:08.380093 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1207 2026-05-18 09:44:08.380115 | Event ID: 12731b80-529e-11f1-949f-a247c0e75d52 2026-05-18 09:44:08.388004 | 2026-05-18 09:44:08.388140 | LOOP [emit-job-header : Print node information] 2026-05-18 09:44:08.644646 | debian-bookworm | ok: 2026-05-18 09:44:08.644844 | debian-bookworm | # Node Information 2026-05-18 09:44:08.644874 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 09:44:08.644918 | debian-bookworm | Hostname: debian 2026-05-18 09:44:08.644936 | debian-bookworm | Username: zuul 2026-05-18 09:44:08.644952 | debian-bookworm | Distro: Debian 12.14 2026-05-18 09:44:08.644971 | debian-bookworm | Provider: regiocloud-a 2026-05-18 09:44:08.644988 | debian-bookworm | Region: 2026-05-18 09:44:08.645005 | debian-bookworm | Label: debian-bookworm 2026-05-18 09:44:08.645021 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 09:44:08.645038 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:a448 2026-05-18 09:44:08.699398 | 2026-05-18 09:44:08.699544 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:09.995173 | debian-bookworm -> localhost | changed 2026-05-18 09:44:10.023619 | 2026-05-18 09:44:10.023847 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 09:44:12.410682 | debian-bookworm -> localhost | changed 2026-05-18 09:44:12.419673 | 2026-05-18 09:44:12.419782 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 09:44:12.933316 | debian-bookworm -> localhost | ok 2026-05-18 09:44:12.945757 | 2026-05-18 09:44:12.945857 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 09:44:13.001589 | debian-bookworm | ok 2026-05-18 09:44:13.054806 | debian-bookworm | included: /var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 09:44:13.071008 | 2026-05-18 09:44:13.071108 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 09:44:15.919655 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 09:44:15.919876 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/5b897d27513b4b51a150da5fed892c9a_id_rsa 2026-05-18 09:44:15.919925 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/5b897d27513b4b51a150da5fed892c9a_id_rsa.pub 2026-05-18 09:44:15.919953 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 09:44:15.919977 | debian-bookworm -> localhost | SHA256:o1UDDUIOpk+fB1Xl9uFc7ztAmSPLIbI6bkdd6dD36tI zuul-build-sshkey 2026-05-18 09:44:15.919999 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 09:44:15.920031 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 09:44:15.920053 | debian-bookworm -> localhost | | o.o ++... | 2026-05-18 09:44:15.920093 | debian-bookworm -> localhost | | o o o ... | 2026-05-18 09:44:15.920122 | debian-bookworm -> localhost | | . . o + + + .| 2026-05-18 09:44:15.920143 | debian-bookworm -> localhost | | o . + + O X o.| 2026-05-18 09:44:15.920163 | debian-bookworm -> localhost | | . o S * * * .| 2026-05-18 09:44:15.920188 | debian-bookworm -> localhost | | * o + . o | 2026-05-18 09:44:15.920215 | debian-bookworm -> localhost | | + . o .| 2026-05-18 09:44:15.920242 | debian-bookworm -> localhost | | + . . E ..| 2026-05-18 09:44:15.920269 | debian-bookworm -> localhost | | o.o o. ..| 2026-05-18 09:44:15.920290 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 09:44:15.920350 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.736226 2026-05-18 09:44:15.930198 | 2026-05-18 09:44:15.930312 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 09:44:15.976481 | debian-bookworm | ok 2026-05-18 09:44:15.992500 | debian-bookworm | included: /var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 09:44:16.002458 | 2026-05-18 09:44:16.002553 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 09:44:16.039002 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:16.073070 | 2026-05-18 09:44:16.073192 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 09:44:16.692121 | debian-bookworm | changed 2026-05-18 09:44:16.697423 | 2026-05-18 09:44:16.697524 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 09:44:16.980237 | debian-bookworm | ok 2026-05-18 09:44:16.989753 | 2026-05-18 09:44:16.989887 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 09:44:17.632489 | debian-bookworm | changed 2026-05-18 09:44:17.639656 | 2026-05-18 09:44:17.639761 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 09:44:18.342909 | debian-bookworm | changed 2026-05-18 09:44:18.348324 | 2026-05-18 09:44:18.348450 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 09:44:18.394462 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:18.400440 | 2026-05-18 09:44:18.400547 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 09:44:19.917327 | debian-bookworm -> localhost | changed 2026-05-18 09:44:19.933679 | 2026-05-18 09:44:19.933785 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 09:44:20.938613 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/5b897d27513b4b51a150da5fed892c9a_id_rsa (zuul-build-sshkey) 2026-05-18 09:44:20.938848 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.038561 2026-05-18 09:44:20.946467 | 2026-05-18 09:44:20.946569 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 09:44:21.655766 | debian-bookworm | ok 2026-05-18 09:44:21.668827 | 2026-05-18 09:44:21.669010 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 09:44:21.745297 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:21.766482 | 2026-05-18 09:44:21.766622 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 09:44:22.589775 | debian-bookworm | ok 2026-05-18 09:44:22.605070 | 2026-05-18 09:44:22.605188 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 09:44:22.633415 | debian-bookworm | ok 2026-05-18 09:44:22.640241 | 2026-05-18 09:44:22.640342 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:22.936307 | debian-bookworm -> localhost | ok 2026-05-18 09:44:22.942905 | 2026-05-18 09:44:22.943018 | TASK [validate-host : Collect information about the host] 2026-05-18 09:44:24.104298 | debian-bookworm | ok 2026-05-18 09:44:24.129283 | 2026-05-18 09:44:24.129392 | TASK [validate-host : Sanitize hostname] 2026-05-18 09:44:24.273369 | debian-bookworm | ok 2026-05-18 09:44:24.343870 | 2026-05-18 09:44:24.344012 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 09:44:25.285652 | debian-bookworm -> localhost | changed 2026-05-18 09:44:25.291699 | 2026-05-18 09:44:25.291866 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 09:44:25.799320 | debian-bookworm | ok 2026-05-18 09:44:25.804341 | 2026-05-18 09:44:25.804441 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 09:44:26.581381 | debian-bookworm -> localhost | changed 2026-05-18 09:44:26.590753 | 2026-05-18 09:44:26.590907 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 09:44:26.896126 | debian-bookworm | ok 2026-05-18 09:44:26.902025 | 2026-05-18 09:44:26.902129 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 09:44:28.067700 | debian-bookworm | changed: 2026-05-18 09:44:28.068257 | debian-bookworm | cd+++++++++ src/ 2026-05-18 09:44:28.068354 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 09:44:28.068410 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 09:44:28.068451 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-18 09:44:28.068489 | debian-bookworm | =2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.7.0) 2026-05-18 09:45:19.436300 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-requests, types-PyYAML 2026-05-18 09:45:19.512383 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20260518 types-requests-2.33.0.20260518 types-simplejson-3.20.0.20260518 types-tabulate-0.10.0.20260508 2026-05-18 09:45:22.306952 | debian-bookworm | openstack_image_manager/main.py:442: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "import_image" [union-attr] 2026-05-18 09:45:22.307128 | debian-bookworm | openstack_image_manager/main.py:809: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "add_tag" [union-attr] 2026-05-18 09:45:22.307149 | debian-bookworm | openstack_image_manager/main.py:814: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "remove_tag" [union-attr] 2026-05-18 09:45:22.307161 | debian-bookworm | openstack_image_manager/main.py:854: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "deactivate_image" [union-attr] 2026-05-18 09:45:22.307173 | debian-bookworm | openstack_image_manager/main.py:858: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "reactivate_image" [union-attr] 2026-05-18 09:45:22.307184 | debian-bookworm | openstack_image_manager/main.py:1082: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "deactivate_image" [union-attr] 2026-05-18 09:45:22.307196 | debian-bookworm | openstack_image_manager/main.py:1111: error: Item "openstack.image.v1._proxy.Proxy" of "openstack.image.v1._proxy.Proxy | openstack.image.v2._proxy.Proxy" has no attribute "deactivate_image" [union-attr] 2026-05-18 09:45:22.307208 | debian-bookworm | Installing missing stub packages: 2026-05-18 09:45:22.307222 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyYAML types-requests types-simplejson types-tabulate 2026-05-18 09:45:22.307234 | debian-bookworm | 2026-05-18 09:45:22.307246 | debian-bookworm | 2026-05-18 09:45:22.307257 | debian-bookworm | Found 7 errors in 1 file (checked 12 source files) 2026-05-18 09:45:22.417088 | debian-bookworm | ERROR 2026-05-18 09:45:22.417258 | debian-bookworm | { 2026-05-18 09:45:22.417291 | debian-bookworm | "delta": "0:00:10.098897", 2026-05-18 09:45:22.417324 | debian-bookworm | "end": "2026-05-18 09:45:22.325750", 2026-05-18 09:45:22.417342 | debian-bookworm | "msg": "non-zero return code", 2026-05-18 09:45:22.417357 | debian-bookworm | "rc": 1, 2026-05-18 09:45:22.417380 | debian-bookworm | "start": "2026-05-18 09:45:12.226853" 2026-05-18 09:45:22.417397 | debian-bookworm | } failure 2026-05-18 09:45:22.418899 | 2026-05-18 09:45:22.418951 | PLAY RECAP 2026-05-18 09:45:22.418993 | debian-bookworm | ok: 10 changed: 7 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2026-05-18 09:45:22.419033 | 2026-05-18 09:45:23.047953 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-18 09:45:23.048820 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:45:24.557212 | 2026-05-18 09:45:24.557367 | PLAY [Base post-fetch] 2026-05-18 09:45:24.588413 | 2026-05-18 09:45:24.588532 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-18 09:45:24.690414 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:45:24.695231 | 2026-05-18 09:45:24.695333 | TASK [fetch-output : Set log path for single node] 2026-05-18 09:45:24.772836 | debian-bookworm | ok 2026-05-18 09:45:24.777314 | 2026-05-18 09:45:24.777414 | LOOP [fetch-output : Ensure local output dirs] 2026-05-18 09:45:26.178717 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/logs" 2026-05-18 09:45:26.782642 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/artifacts" 2026-05-18 09:45:27.372382 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b897d27513b4b51a150da5fed892c9a/work/docs" 2026-05-18 09:45:27.389867 | 2026-05-18 09:45:27.389970 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 09:45:28.835917 | debian-bookworm | changed: 2026-05-18 09:45:28.836156 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 09:45:28.836221 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 09:45:28.836255 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 09:45:28.836298 | debian-bookworm | changed: All items complete 2026-05-18 09:45:28.836321 | 2026-05-18 09:45:29.689519 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:45:30.597002 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:45:30.619349 | 2026-05-18 09:45:30.619449 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 09:45:31.567996 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.004342 2026-05-18 09:45:32.051657 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012003 2026-05-18 09:45:32.064015 | 2026-05-18 09:45:32.064087 | PLAY RECAP 2026-05-18 09:45:32.064129 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 09:45:32.064151 | 2026-05-18 09:45:32.581069 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:45:32.581898 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:45:34.353767 | 2026-05-18 09:45:34.353911 | PLAY [Base post] 2026-05-18 09:45:34.381858 | 2026-05-18 09:45:34.381981 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 09:45:35.167077 | debian-bookworm | changed 2026-05-18 09:45:35.175155 | 2026-05-18 09:45:35.175259 | PLAY RECAP 2026-05-18 09:45:35.175313 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 09:45:35.175365 | 2026-05-18 09:45:35.384126 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:45:35.385649 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 09:45:36.392028 | 2026-05-18 09:45:36.392157 | PLAY [Base post-logs] 2026-05-18 09:45:36.401254 | 2026-05-18 09:45:36.401359 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 09:45:36.883803 | localhost | changed 2026-05-18 09:45:36.891920 | 2026-05-18 09:45:36.892045 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 09:45:36.937500 | localhost | ok 2026-05-18 09:45:36.940142 | 2026-05-18 09:45:36.940247 | TASK [Set zuul-log-path fact] 2026-05-18 09:45:36.974965 | localhost | ok 2026-05-18 09:45:36.981996 | 2026-05-18 09:45:36.982087 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:45:37.006341 | localhost | ok 2026-05-18 09:45:37.009208 | 2026-05-18 09:45:37.009329 | TASK [upload-logs : Create log directories] 2026-05-18 09:45:37.568709 | localhost | changed 2026-05-18 09:45:37.571417 | 2026-05-18 09:45:37.571503 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 09:45:38.127996 | localhost -> localhost | ok: Runtime: 0:00:00.011340 2026-05-18 09:45:38.131704 | 2026-05-18 09:45:38.131793 | TASK [upload-logs : Upload logs to log server] 2026-05-18 09:45:38.950923 | localhost | Output suppressed because no_log was given 2026-05-18 09:45:38.952592 | 2026-05-18 09:45:38.952677 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 09:45:39.005403 | localhost | skipping: Conditional result was False 2026-05-18 09:45:39.011040 | localhost | skipping: Conditional result was False 2026-05-18 09:45:39.018529 | 2026-05-18 09:45:39.019903 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 09:45:39.060394 | localhost | skipping: Conditional result was False 2026-05-18 09:45:39.061484 | 2026-05-18 09:45:39.065747 | localhost | skipping: Conditional result was False 2026-05-18 09:45:39.079346 | 2026-05-18 09:45:39.079699 | LOOP [upload-logs : Upload console log and json output]