0s autopkgtest [04:41:46]: starting date and time: 2026-02-06 04:41:46+0000 0s autopkgtest [04:41:46]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [04:41:46]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8rqggwjo/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,localhost,localdomain,internal,login.ubuntu.com,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:dulwich --apt-upgrade dulwich --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=dulwich/1.0.0-2 -- lxd -r lxd-armhf-10.145.243.229 lxd-armhf-10.145.243.229:autopkgtest/ubuntu/resolute/armhf 23s autopkgtest [04:42:09]: testbed dpkg architecture: armhf 25s autopkgtest [04:42:11]: testbed apt version: 3.1.14 30s autopkgtest [04:42:16]: @@@@@@@@@@@@@@@@@@@@ test bed setup 32s autopkgtest [04:42:18]: testbed release detected to be: None 41s autopkgtest [04:42:27]: updating testbed package index (apt update) 42s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 43s Get:2 http://ftpmaster.internal/ubuntu resolute InRelease [124 kB] 43s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 43s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 43s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [32.6 kB] 43s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5260 B] 43s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1593 kB] 43s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [220 kB] 43s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf Packages [254 kB] 43s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf Packages [1304 kB] 43s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse armhf Packages [8048 B] 43s Get:12 http://ftpmaster.internal/ubuntu resolute/universe Sources [21.3 MB] 44s Get:13 http://ftpmaster.internal/ubuntu resolute/multiverse Sources [310 kB] 44s Get:14 http://ftpmaster.internal/ubuntu resolute/main Sources [1410 kB] 44s Get:15 http://ftpmaster.internal/ubuntu resolute/main armhf Packages [1374 kB] 44s Get:16 http://ftpmaster.internal/ubuntu resolute/universe armhf Packages [14.9 MB] 44s Get:17 http://ftpmaster.internal/ubuntu resolute/multiverse armhf Packages [176 kB] 47s Fetched 43.2 MB in 5s (8476 kB/s) 49s Reading package lists... 55s autopkgtest [04:42:41]: upgrading testbed (apt dist-upgrade and autopurge) 57s Reading package lists... 57s Building dependency tree... 57s Reading state information... 57s Calculating upgrade... 58s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 60s Reading package lists... 61s Building dependency tree... 61s Reading state information... 61s Solving dependencies... 61s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 65s autopkgtest [04:42:51]: rebooting testbed after setup commands that affected boot 108s autopkgtest [04:43:34]: testbed running kernel: Linux 6.8.0-87-generic #88~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue Oct 14 14:00:09 UTC 2 135s autopkgtest [04:44:01]: @@@@@@@@@@@@@@@@@@@@ apt-source dulwich 146s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/universe dulwich 1.0.0-2 (dsc) [2257 B] 146s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/universe dulwich 1.0.0-2 (tar) [1146 kB] 146s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/universe dulwich 1.0.0-2 (diff) [9360 B] 147s gpgv: Signature made Mon Feb 2 09:49:45 2026 UTC 147s gpgv: using RSA key E3939120702FEA41D181D373869D24B4EE7B4DA6 147s gpgv: issuer "jelmer@debian.org" 147s gpgv: Can't check signature: No public key 147s dpkg-source: warning: cannot verify inline signature for ./dulwich_1.0.0-2.dsc: no acceptable signature found 147s autopkgtest [04:44:13]: testing package dulwich version 1.0.0-2 149s autopkgtest [04:44:15]: build not needed 151s autopkgtest [04:44:17]: test testsuite3: preparing testbed 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 153s Solving dependencies... 154s The following NEW packages will be installed: 154s git git-man liberror-perl libpython3.14-minimal libpython3.14-stdlib 154s python3-all python3-dulwich python3-gpg python3-merge3 python3-sshsig 154s python3.14 python3.14-minimal 154s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 154s Need to get 13.1 MB of archives. 154s After this operation, 61.0 MB of additional disk space will be used. 154s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf libpython3.14-minimal armhf 3.14.2-1 [905 kB] 155s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf python3.14-minimal armhf 3.14.2-1 [2155 kB] 155s Get:3 http://ftpmaster.internal/ubuntu resolute/main armhf liberror-perl all 0.17030-1 [23.5 kB] 155s Get:4 http://ftpmaster.internal/ubuntu resolute/main armhf git-man all 1:2.51.0-1ubuntu1 [1179 kB] 155s Get:5 http://ftpmaster.internal/ubuntu resolute/main armhf git armhf 1:2.51.0-1ubuntu1 [4649 kB] 155s Get:6 http://ftpmaster.internal/ubuntu resolute/main armhf libpython3.14-stdlib armhf 3.14.2-1 [2270 kB] 155s Get:7 http://ftpmaster.internal/ubuntu resolute/main armhf python3.14 armhf 3.14.2-1 [816 kB] 155s Get:8 http://ftpmaster.internal/ubuntu resolute/main armhf python3-all armhf 3.13.9-3 [890 B] 155s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf python3-dulwich armhf 1.0.0-2 [756 kB] 155s Get:10 http://ftpmaster.internal/ubuntu resolute/main armhf python3-gpg armhf 1.24.2-3ubuntu2 [296 kB] 155s Get:11 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-merge3 all 0.0.8-1build1 [10.3 kB] 155s Get:12 http://ftpmaster.internal/ubuntu resolute/universe armhf python3-sshsig all 0.2.2-2 [10.8 kB] 155s Fetched 13.1 MB in 1s (13.4 MB/s) 155s Selecting previously unselected package libpython3.14-minimal:armhf. 156s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 68395 files and directories currently installed.) 156s Preparing to unpack .../00-libpython3.14-minimal_3.14.2-1_armhf.deb ... 156s Unpacking libpython3.14-minimal:armhf (3.14.2-1) ... 156s Selecting previously unselected package python3.14-minimal. 156s Preparing to unpack .../01-python3.14-minimal_3.14.2-1_armhf.deb ... 156s Unpacking python3.14-minimal (3.14.2-1) ... 156s Selecting previously unselected package liberror-perl. 156s Preparing to unpack .../02-liberror-perl_0.17030-1_all.deb ... 156s Unpacking liberror-perl (0.17030-1) ... 156s Selecting previously unselected package git-man. 156s Preparing to unpack .../03-git-man_1%3a2.51.0-1ubuntu1_all.deb ... 156s Unpacking git-man (1:2.51.0-1ubuntu1) ... 156s Selecting previously unselected package git. 156s Preparing to unpack .../04-git_1%3a2.51.0-1ubuntu1_armhf.deb ... 156s Unpacking git (1:2.51.0-1ubuntu1) ... 156s Selecting previously unselected package libpython3.14-stdlib:armhf. 156s Preparing to unpack .../05-libpython3.14-stdlib_3.14.2-1_armhf.deb ... 156s Unpacking libpython3.14-stdlib:armhf (3.14.2-1) ... 156s Selecting previously unselected package python3.14. 156s Preparing to unpack .../06-python3.14_3.14.2-1_armhf.deb ... 156s Unpacking python3.14 (3.14.2-1) ... 156s Selecting previously unselected package python3-all. 156s Preparing to unpack .../07-python3-all_3.13.9-3_armhf.deb ... 156s Unpacking python3-all (3.13.9-3) ... 156s Selecting previously unselected package python3-dulwich. 156s Preparing to unpack .../08-python3-dulwich_1.0.0-2_armhf.deb ... 156s Unpacking python3-dulwich (1.0.0-2) ... 156s Selecting previously unselected package python3-gpg. 156s Preparing to unpack .../09-python3-gpg_1.24.2-3ubuntu2_armhf.deb ... 156s Unpacking python3-gpg (1.24.2-3ubuntu2) ... 156s Selecting previously unselected package python3-merge3. 156s Preparing to unpack .../10-python3-merge3_0.0.8-1build1_all.deb ... 156s Unpacking python3-merge3 (0.0.8-1build1) ... 156s Selecting previously unselected package python3-sshsig. 156s Preparing to unpack .../11-python3-sshsig_0.2.2-2_all.deb ... 156s Unpacking python3-sshsig (0.2.2-2) ... 156s Setting up python3-sshsig (0.2.2-2) ... 157s Setting up libpython3.14-minimal:armhf (3.14.2-1) ... 157s Setting up liberror-perl (0.17030-1) ... 157s Setting up python3-merge3 (0.0.8-1build1) ... 157s Setting up python3-gpg (1.24.2-3ubuntu2) ... 157s Setting up python3-dulwich (1.0.0-2) ... 159s Setting up git-man (1:2.51.0-1ubuntu1) ... 159s Setting up python3.14-minimal (3.14.2-1) ... 160s Setting up libpython3.14-stdlib:armhf (3.14.2-1) ... 160s Setting up git (1:2.51.0-1ubuntu1) ... 160s Setting up python3.14 (3.14.2-1) ... 161s Setting up python3-all (3.13.9-3) ... 161s Processing triggers for man-db (2.13.1-1) ... 162s Processing triggers for systemd (259-1ubuntu3) ... 171s autopkgtest [04:44:37]: test testsuite3: [----------------------- 173s ========= Running tests with python3.14 ========== 177s .......sssssss...............................................................................................................................................................................................................................................................................................................................................s..................../tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:4635: DeprecationWarning: 'nturl2path' is deprecated and slated for removal in Python 3.19; use 'urllib.request' instead 177s from nturl2path import url2pathname 182s ...........................................................................................................................................................sss.........s................ss.s.s.....................s.s...............................................................sssssssssssss.s..........................................................................................................................................................................................................................................................s...................................../usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 182s _warnings.warn(self.warn_message, ResourceWarning) 185s ..................................../usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 185s _warnings.warn(self.warn_message, ResourceWarning) 186s ../usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 186s _warnings.warn(self.warn_message, ResourceWarning) 187s ./usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 187s _warnings.warn(self.warn_message, ResourceWarning) 187s ./usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 187s _warnings.warn(self.warn_message, ResourceWarning) 187s ../usr/lib/python3.14/tempfile.py:484: ResourceWarning: Implicitly cleaning up 187s _warnings.warn(self.warn_message, ResourceWarning) 188s ...............................................................Warning: Failed to open GIT_TRACE file /nonexistent/path/trace.log: [Errno 2] No such file or directory: '/nonexistent/path/trace.log' 207s .......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................s...s.............................................................................................................................................s.s..s....................................................................ssss.s...............................................................................................................................................................................................................................................................................................................................................................................................................................................s....ss.s...ssu..........................s........s..........................................................................................................................x......................................................................................................................................................s...............................................................................................................Test template content.....................................................................................................................................................s.........................................................counting objects: 3, done. 207s found 0 deltas to reuse 208s writing pack data: 0/3 .........................counting objects: 4, done. 208s found 0 deltas to reuse 208s writing pack data: 0/4 counting objects: 3, done. 208s found 0 deltas to reuse 215s writing pack data: 0/3 ...................................................................................................................................................................................s..................................................127.0.0.1 - - [06/Feb/2026 04:45:21] "GET /info/refs?service=git-upload-pack HTTP/1.1" 200 311 215s counting objects: 2, done. 215s 127.0.0.1 - - [06/Feb/2026 04:45:21] "POST /git-upload-pack HTTP/1.1" 200 258 215s copying pack entries: 0/2 copying pack entries: 1/2 copied 1 pack entries 215s generating index: 0/2 generating index: 1/2 .127.0.0.1 - - [06/Feb/2026 04:45:21] "GET /info/refs?service=git-receive-pack HTTP/1.1" 200 214 215s counting objects: 2, done. 215s found 0 deltas to reuse 215s 127.0.0.1 - - [06/Feb/2026 04:45:21] "POST /git-receive-pack HTTP/1.1" 200 52 216s Push to http://localhost:38889 successful. 216s Ref refs/heads/master updated 217s ....................................................counting objects: 3, done. 217s found 0 deltas to reuse 217s writing pack data: 0/3 .counting objects: 4, done. 217s found 0 deltas to reuse 217s writing pack data: 0/4 counting objects: 3, done. 217s found 0 deltas to reuse 221s writing pack data: 0/3 ........................................................................................counting objects: 4, done. 221s found 0 deltas to reuse 221s writing pack data: 0/4 .counting objects: 3, done. 221s found 0 deltas to reuse 221s writing pack data: 0/3 ................counting objects: 4, done. 221s found 0 deltas to reuse 274s writing pack data: 0/4 ................................................................................ss...sssssssssssssssssssssssssssssssssssssssssssssssssssssssss..............................................s......s...............s.............................s.............................................s.............................................s.............s......................s................./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 274s result = self.fetch_pack( 276s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 276s result = self.fetch_pack( 277s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 277s result = self.fetch_pack( 278s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 278s result = self.fetch_pack( 279s ..................Auto-merging conflict.txt 279s CONFLICT (content): Merge conflict in conflict.txt 279s Automatic merge failed; fix conflicts and then commit the result. 331s .....sssssssssssssss.......s.............sssss............................................................................................ss.sss.ss..........................................sssssssssssssssss..............sssssssssssssssssssssssssssssssssssssssssssss 331s ====================================================================== 331s UNEXPECTED SUCCESS: test_verify_invalid_signature (tests.test_signature.GPGSignatureVendorTests.test_verify_invalid_signature) 331s Test that verify raises an error for invalid signatures. 331s ---------------------------------------------------------------------- 331s Ran 3930 tests in 156.730s 331s 331s FAILED (skipped=211, expected failures=1, unexpected successes=1) 331s file.txt | 1 + 331s 1 files changed, 1 insertions(+), 0 deletions(-) 331s self test passed 332s ========= Running tests with python3.13 ========== 343s .......sssssss...............................................................................................................................................................................................................................................................................................................................................s...............................................................................................................................................................................sss.........s................ss.s.s.....................s.s...............................................................sssssssssssss.s..........................................................................................................................................................................................................................................................s..............................................................................................................................................Warning: Failed to open GIT_TRACE file /nonexistent/path/trace.log: [Errno 2] No such file or directory: '/nonexistent/path/trace.log' 366s .......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................s...s.............................................................................................................................................s.s..s....................................................................ssss.s...............................................................................................................................................................................................................................................................................................................................................................................................................................................s....ss.s...ssu..........................s........s..........................................................................................................................x......................................................................................................................................................s...............................................................................................................Test template content.....................................................................................................................................................s.........................................................counting objects: 3, done. 366s found 0 deltas to reuse 368s writing pack data: 0/3 .........................counting objects: 4, done. 368s found 0 deltas to reuse 368s writing pack data: 0/4 counting objects: 3, done. 368s found 0 deltas to reuse 376s writing pack data: 0/3 ...................................................................................................................................................................................s..................................................127.0.0.1 - - [06/Feb/2026 04:48:02] "GET /info/refs?service=git-upload-pack HTTP/1.1" 200 311 376s counting objects: 2, done. 376s 127.0.0.1 - - [06/Feb/2026 04:48:02] "POST /git-upload-pack HTTP/1.1" 200 258 376s copying pack entries: 0/2 copying pack entries: 1/2 copied 1 pack entries 376s generating index: 0/2 generating index: 1/2 .127.0.0.1 - - [06/Feb/2026 04:48:02] "GET /info/refs?service=git-receive-pack HTTP/1.1" 200 214 376s counting objects: 2, done. 376s found 0 deltas to reuse 376s 127.0.0.1 - - [06/Feb/2026 04:48:02] "POST /git-receive-pack HTTP/1.1" 200 52 376s Push to http://localhost:39995 successful. 376s Ref refs/heads/master updated 378s ....................................................counting objects: 3, done. 378s found 0 deltas to reuse 378s writing pack data: 0/3 .counting objects: 4, done. 378s found 0 deltas to reuse 378s writing pack data: 0/4 counting objects: 3, done. 378s found 0 deltas to reuse 381s writing pack data: 0/3 ........................................................................................counting objects: 4, done. 381s found 0 deltas to reuse 381s writing pack data: 0/4 .counting objects: 3, done. 381s found 0 deltas to reuse 382s writing pack data: 0/3 ................counting objects: 4, done. 382s found 0 deltas to reuse 437s writing pack data: 0/4 ................................................................................ss...sssssssssssssssssssssssssssssssssssssssssssssssssssssssss..............................................s......s...............s.............................s.............................................s.............................................s.............s......................s................./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 437s result = self.fetch_pack( 438s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 438s result = self.fetch_pack( 439s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 439s result = self.fetch_pack( 440s ./tmp/autopkgtest.VGj6bJ/build.32v/src/dulwich/client.py:1285: ResourceWarning: DumbHTTPObjectStore was destroyed without calling close(). Temporary pack directory may not be cleaned up properly. 440s result = self.fetch_pack( 441s ..................Auto-merging conflict.txt 441s CONFLICT (content): Merge conflict in conflict.txt 441s Automatic merge failed; fix conflicts and then commit the result. 496s .....sssssssssssssss.......s.............sssss............................................................................................ss.sss.ss..........................................sssssssssssssssss..............sssssssssssssssssssssssssssssssssssssssssssss 496s ====================================================================== 496s file.txt | 1 + 496s 1 files changed, 1 insertions(+), 0 deletions(-) 496s self test passed 496s UNEXPECTED SUCCESS: test_verify_invalid_signature (tests.test_signature.GPGSignatureVendorTests.test_verify_invalid_signature) 496s Test that verify raises an error for invalid signatures. 496s ---------------------------------------------------------------------- 496s Ran 3930 tests in 162.366s 496s 496s FAILED (skipped=211, expected failures=1, unexpected successes=1) 496s autopkgtest [04:50:02]: test testsuite3: -----------------------] 501s testsuite3 FAIL non-zero exit status 1 501s autopkgtest [04:50:07]: test testsuite3: - - - - - - - - - - results - - - - - - - - - - 504s autopkgtest [04:50:10]: @@@@@@@@@@@@@@@@@@@@ summary 504s testsuite3 FAIL non-zero exit status 1