0s autopkgtest [18:04:54]: starting date and time: 2025-10-18 18:04:54+0000 0s autopkgtest [18:04:54]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [18:04:54]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.9dc44s43/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults --apt-upgrade imediff --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python3-defaults/3.13.7-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-10.secgroup --name adt-resolute-arm64-imediff-20251018-180454-juju-7f2275-prod-proposed-migration-environment-2-c59236ea-6aa7-4c7d-b9ab-b21bfe523f54 --image adt/ubuntu-resolute-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-arm64-imediff-20251018-180454-juju-7f2275-prod-proposed-migration-environment-2-c59236ea-6aa7-4c7d-b9ab-b21bfe523f54 from image adt/ubuntu-resolute-arm64-server-20251018.img (UUID f7a49384-4e4d-4350-9a26-1f59236f89dd)... 54s autopkgtest [18:05:48]: testbed dpkg architecture: arm64 55s autopkgtest [18:05:49]: testbed apt version: 3.1.6ubuntu2 55s autopkgtest [18:05:49]: @@@@@@@@@@@@@@@@@@@@ test bed setup 55s autopkgtest [18:05:49]: testbed release detected to be: None 56s autopkgtest [18:05:50]: updating testbed package index (apt update) 56s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 57s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 57s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 57s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 57s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 57s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [456 kB] 57s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [50.7 kB] 57s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [16.7 kB] 57s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 Packages [99.7 kB] 57s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 Packages [43.8 kB] 57s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 Packages [322 kB] 57s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 Packages [6524 B] 57s Fetched 1083 kB in 1s (1141 kB/s) 58s Reading package lists... 59s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 59s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 59s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 59s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 60s Reading package lists... 60s Reading package lists... 60s Building dependency tree... 60s Reading state information... 60s Calculating upgrade... 61s The following packages will be upgraded: 61s apt flash-kernel gir1.2-girepository-2.0 libapt-pkg7.0 libgirepository-1.0-1 61s libpython3-stdlib lto-disabled-list python3 python3-minimal 61s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 61s Need to get 2671 kB of archives. 61s After this operation, 66.6 kB of additional disk space will be used. 61s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 python3-minimal arm64 3.13.7-2 [27.8 kB] 61s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 python3 arm64 3.13.7-2 [23.9 kB] 61s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libpython3-stdlib arm64 3.13.7-2 [10.6 kB] 61s Get:4 http://ftpmaster.internal/ubuntu resolute/main arm64 libapt-pkg7.0 arm64 3.1.8ubuntu1 [1055 kB] 61s Get:5 http://ftpmaster.internal/ubuntu resolute/main arm64 apt arm64 3.1.8ubuntu1 [1373 kB] 62s Get:6 http://ftpmaster.internal/ubuntu resolute/main arm64 libgirepository-1.0-1 arm64 1.86.0-6 [84.5 kB] 62s Get:7 http://ftpmaster.internal/ubuntu resolute/main arm64 gir1.2-girepository-2.0 arm64 1.86.0-6 [25.3 kB] 62s Get:8 http://ftpmaster.internal/ubuntu resolute/main arm64 flash-kernel arm64 3.109ubuntu7 [58.8 kB] 62s Get:9 http://ftpmaster.internal/ubuntu resolute/main arm64 lto-disabled-list all 71 [12.5 kB] 62s dpkg-preconfigure: unable to re-open stdin: No such file or directory 62s Fetched 2671 kB in 1s (2989 kB/s) 62s (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 ... 83359 files and directories currently installed.) 62s Preparing to unpack .../python3-minimal_3.13.7-2_arm64.deb ... 62s Unpacking python3-minimal (3.13.7-2) over (3.13.7-1) ... 62s Setting up python3-minimal (3.13.7-2) ... 63s (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 ... 83359 files and directories currently installed.) 63s Preparing to unpack .../0-python3_3.13.7-2_arm64.deb ... 63s running python pre-rtupdate hooks for python3.13... 63s Unpacking python3 (3.13.7-2) over (3.13.7-1) ... 63s Preparing to unpack .../1-libpython3-stdlib_3.13.7-2_arm64.deb ... 63s Unpacking libpython3-stdlib:arm64 (3.13.7-2) over (3.13.7-1) ... 63s Preparing to unpack .../2-libapt-pkg7.0_3.1.8ubuntu1_arm64.deb ... 63s Unpacking libapt-pkg7.0:arm64 (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 63s Preparing to unpack .../3-apt_3.1.8ubuntu1_arm64.deb ... 63s Unpacking apt (3.1.8ubuntu1) over (3.1.6ubuntu2) ... 63s Preparing to unpack .../4-libgirepository-1.0-1_1.86.0-6_arm64.deb ... 63s Unpacking libgirepository-1.0-1:arm64 (1.86.0-6) over (1.84.0-1) ... 63s Preparing to unpack .../5-gir1.2-girepository-2.0_1.86.0-6_arm64.deb ... 63s Unpacking gir1.2-girepository-2.0:arm64 (1.86.0-6) over (1.84.0-1) ... 64s Preparing to unpack .../6-flash-kernel_3.109ubuntu7_arm64.deb ... 64s Unpacking flash-kernel (3.109ubuntu7) over (3.109ubuntu6) ... 64s Preparing to unpack .../7-lto-disabled-list_71_all.deb ... 64s Unpacking lto-disabled-list (71) over (69) ... 64s Setting up lto-disabled-list (71) ... 64s Setting up libgirepository-1.0-1:arm64 (1.86.0-6) ... 64s Setting up libapt-pkg7.0:arm64 (3.1.8ubuntu1) ... 64s Setting up libpython3-stdlib:arm64 (3.13.7-2) ... 64s Setting up apt (3.1.8ubuntu1) ... 65s Setting up python3 (3.13.7-2) ... 65s running python rtupdate hooks for python3.13... 65s running python post-rtupdate hooks for python3.13... 65s Setting up gir1.2-girepository-2.0:arm64 (1.86.0-6) ... 65s Setting up flash-kernel (3.109ubuntu7) ... 65s flash-kernel: deferring update (trigger activated) 65s Processing triggers for libc-bin (2.42-0ubuntu3) ... 65s Processing triggers for man-db (2.13.1-1) ... 67s Processing triggers for initramfs-tools (0.150ubuntu3) ... 67s update-initramfs: Generating /boot/initrd.img-6.17.0-5-generic 87s System running in EFI mode, skipping. 87s Processing triggers for flash-kernel (3.109ubuntu7) ... 87s System running in EFI mode, skipping. 87s autopkgtest [18:06:21]: upgrading testbed (apt dist-upgrade and autopurge) 88s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s Calculating upgrade... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s Solving dependencies... 91s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 91s autopkgtest [18:06:25]: rebooting testbed after setup commands that affected boot 118s autopkgtest [18:06:52]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 09:50:31 UTC 2025 121s autopkgtest [18:06:55]: @@@@@@@@@@@@@@@@@@@@ apt-source imediff 123s Get:1 http://ftpmaster.internal/ubuntu resolute/universe imediff 3.4.0-1 (dsc) [2038 B] 123s Get:2 http://ftpmaster.internal/ubuntu resolute/universe imediff 3.4.0-1 (tar) [72.4 kB] 123s Get:3 http://ftpmaster.internal/ubuntu resolute/universe imediff 3.4.0-1 (diff) [6588 B] 123s gpgv: Signature made Tue Feb 4 14:24:48 2025 UTC 123s gpgv: using RSA key 3133724D6207881579E95D621E1356881DD8D791 123s gpgv: issuer "osamu@debian.org" 123s gpgv: Can't check signature: No public key 123s dpkg-source: warning: cannot verify inline signature for ./imediff_3.4.0-1.dsc: no acceptable signature found 123s autopkgtest [18:06:57]: testing package imediff version 3.4.0-1 124s autopkgtest [18:06:58]: build not needed 124s autopkgtest [18:06:58]: test check-script: preparing testbed 124s Reading package lists... 124s Building dependency tree... 124s Reading state information... 125s Solving dependencies... 125s The following NEW packages will be installed: 125s imediff libsodium23 vim vim-common vim-runtime 125s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 125s Need to get 9936 kB of archives. 125s After this operation, 45.8 MB of additional disk space will be used. 125s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 vim-common all 2:9.1.0967-1ubuntu6 [397 kB] 126s Get:2 http://ftpmaster.internal/ubuntu resolute/main arm64 vim-runtime all 2:9.1.0967-1ubuntu6 [7486 kB] 126s Get:3 http://ftpmaster.internal/ubuntu resolute/main arm64 libsodium23 arm64 1.0.18-1build3 [119 kB] 126s Get:4 http://ftpmaster.internal/ubuntu resolute/main arm64 vim arm64 2:9.1.0967-1ubuntu6 [1870 kB] 126s Get:5 http://ftpmaster.internal/ubuntu resolute/universe arm64 imediff all 3.4.0-1 [63.6 kB] 127s Fetched 9936 kB in 1s (8412 kB/s) 127s Selecting previously unselected package vim-common. 127s (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 ... 83359 files and directories currently installed.) 127s Preparing to unpack .../vim-common_2%3a9.1.0967-1ubuntu6_all.deb ... 127s Unpacking vim-common (2:9.1.0967-1ubuntu6) ... 127s Selecting previously unselected package vim-runtime. 127s Preparing to unpack .../vim-runtime_2%3a9.1.0967-1ubuntu6_all.deb ... 127s Adding 'diversion of /usr/share/vim/vim91/doc/help.txt to /usr/share/vim/vim91/doc/help.txt.vim-tiny by vim-runtime' 127s Adding 'diversion of /usr/share/vim/vim91/doc/tags to /usr/share/vim/vim91/doc/tags.vim-tiny by vim-runtime' 127s Unpacking vim-runtime (2:9.1.0967-1ubuntu6) ... 127s Selecting previously unselected package libsodium23:arm64. 127s Preparing to unpack .../libsodium23_1.0.18-1build3_arm64.deb ... 127s Unpacking libsodium23:arm64 (1.0.18-1build3) ... 127s Selecting previously unselected package vim. 127s Preparing to unpack .../vim_2%3a9.1.0967-1ubuntu6_arm64.deb ... 127s Unpacking vim (2:9.1.0967-1ubuntu6) ... 127s Selecting previously unselected package imediff. 127s Preparing to unpack .../imediff_3.4.0-1_all.deb ... 127s Unpacking imediff (3.4.0-1) ... 127s Setting up libsodium23:arm64 (1.0.18-1build3) ... 127s Setting up vim-common (2:9.1.0967-1ubuntu6) ... 127s Setting up vim-runtime (2:9.1.0967-1ubuntu6) ... 127s Setting up vim (2:9.1.0967-1ubuntu6) ... 127s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/ex (ex) in auto mode 127s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/rview (rview) in auto mode 128s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/rvim (rvim) in auto mode 128s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vi (vi) in auto mode 128s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/view (view) in auto mode 128s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vim (vim) in auto mode 128s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vimdiff (vimdiff) in auto mode 128s Setting up imediff (3.4.0-1) ... 128s Processing triggers for man-db (2.13.1-1) ... 128s Processing triggers for libc-bin (2.42-0ubuntu3) ... 129s autopkgtest [18:07:03]: test check-script: [----------------------- 130s Simple check of diff23lib library 130s test_diff23 (__main__.TestImediff.test_diff23) ... 130s I: _diff23 start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_diff23.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _diff23 end <<< 130s ok 130s test_diff3lib_abc (__main__.TestImediff.test_diff3lib_abc) ... ok 130s test_diff3lib_doctest (__main__.TestImediff.test_diff3lib_doctest) ... 0 failures out of 25 tests -- ok 130s test_imediff2 (__main__.TestImediff.test_imediff2) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff2_a (__main__.TestImediff.test_imediff2_a) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff2_b (__main__.TestImediff.test_imediff2_b) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff2_d (__main__.TestImediff.test_imediff2_d) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff2_f (__main__.TestImediff.test_imediff2_f) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff3 (__main__.TestImediff.test_imediff3) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff3_a (__main__.TestImediff.test_imediff3_a) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff3_b (__main__.TestImediff.test_imediff3_b) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 130s ok 130s test_imediff3_c (__main__.TestImediff.test_imediff3_c) ... 130s I: _imediff start >>> 130s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 130s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 130s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 130s I: PYTHONPATH = 130s I: _imediff end <<< 131s ok 131s test_imediff3_d (__main__.TestImediff.test_imediff3_d) ... 131s I: _imediff start >>> 131s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 131s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 131s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 131s I: PYTHONPATH = 131s I: _imediff end <<< 131s ok 131s test_imediff3_f (__main__.TestImediff.test_imediff3_f) ... 131s I: _imediff start >>> 131s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 131s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 131s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 131s I: PYTHONPATH = 131s I: _imediff end <<< 131s ok 131s test_imediff3_g (__main__.TestImediff.test_imediff3_g) ... 131s I: _imediff start >>> 131s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' 131s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/_imediff.py' (active) 131s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 131s I: PYTHONPATH = 131s I: _imediff end <<< 131s ok 131s test_lines2lib_doctest (__main__.TestImediff.test_lines2lib_doctest) ... 0 failures out of 8 tests -- ok 131s 131s ---------------------------------------------------------------------- 131s Ran 16 tests in 1.065s 131s 131s OK 131s I: cwd_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src' 131s I: test_file = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test/test_unittest_all.py' (active) 131s I: test_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/test' (active) 131s I: base_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src' 131s I: test in the original source tree invoked 131s I: doctest_dir = '/tmp/autopkgtest.UNUzpi/build.Ket/src/src/imediff' 131s I: PYTHONPATH = 131s Copy imediff to here to avoid contaminating system 131s Syntax check of installed imediff 131s Syntax check of installed git-ime 131s Simple invocation check of imediff 131s Simple invocation check of git-ime 131s ============================================================ 131s 131s Test results: OK 131s 131s autopkgtest [18:07:05]: test check-script: -----------------------] 132s check-script PASS 132s autopkgtest [18:07:06]: test check-script: - - - - - - - - - - results - - - - - - - - - - 132s autopkgtest [18:07:06]: @@@@@@@@@@@@@@@@@@@@ summary 132s check-script PASS