0s autopkgtest [18:23:59]: starting date and time: 2024-07-26 18:23:59+0000 0s autopkgtest [18:23:59]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [18:23:59]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.1i523kzx/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,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:ruby-timecop --apt-upgrade ruby-timecop --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ruby-timecop/0.9.10-1 -- lxd -r lxd-armhf-10.145.243.27 lxd-armhf-10.145.243.27:autopkgtest/ubuntu/oracular/armhf 65s autopkgtest [18:25:04]: testbed dpkg architecture: armhf 67s autopkgtest [18:25:06]: testbed apt version: 2.9.6 67s autopkgtest [18:25:06]: @@@@@@@@@@@@@@@@@@@@ test bed setup 75s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 75s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [420 kB] 75s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [52.1 kB] 75s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 75s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [4288 B] 75s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf Packages [66.1 kB] 75s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf c-n-f Metadata [1428 B] 75s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf Packages [1368 B] 75s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf c-n-f Metadata [120 B] 75s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf Packages [384 kB] 76s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf c-n-f Metadata [6916 B] 76s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf Packages [2072 B] 76s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf c-n-f Metadata [120 B] 78s Fetched 1073 kB in 1s (1014 kB/s) 78s Reading package lists... 95s tee: /proc/self/fd/2: Permission denied 117s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 117s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 117s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 117s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 119s Reading package lists... 119s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Calculating upgrade... 121s The following package was automatically installed and is no longer required: 121s python3-six 121s Use 'apt autoremove' to remove it. 121s The following packages will be upgraded: 121s bind9-dnsutils bind9-host bind9-libs cloud-init dmsetup gcc-14-base gdisk 121s kpartx libbpf1 libdevmapper1.02.1 libgcc-s1 liblz4-1 libnspr4 libp11-kit0 121s libstdc++6 libudisks2-0 libxml2 logrotate mawk multipath-tools 121s netcat-openbsd networkd-dispatcher pci.ids python3-launchpadlib rsyslog 121s strace systemd-hwe-hwdb ubuntu-pro-client ubuntu-pro-client-l10n udisks2 121s 30 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s Need to get 6826 kB of archives. 121s After this operation, 18.4 kB of additional disk space will be used. 121s Get:1 http://ftpmaster.internal/ubuntu oracular/main armhf gcc-14-base armhf 14.1.0-5ubuntu1 [49.8 kB] 121s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf libstdc++6 armhf 14.1.0-5ubuntu1 [711 kB] 122s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf libgcc-s1 armhf 14.1.0-5ubuntu1 [40.8 kB] 122s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf liblz4-1 armhf 1.9.4-3 [52.7 kB] 122s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf libp11-kit0 armhf 0.25.5-2ubuntu1 [259 kB] 122s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf mawk armhf 1.3.4.20240622-2 [115 kB] 122s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf libdevmapper1.02.1 armhf 2:1.02.196-1ubuntu1 [135 kB] 122s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf dmsetup armhf 2:1.02.196-1ubuntu1 [81.3 kB] 122s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf libbpf1 armhf 1:1.4.5-1 [151 kB] 122s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf libxml2 armhf 2.12.7+dfsg-3 [560 kB] 122s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf logrotate armhf 3.22.0-1 [51.5 kB] 122s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf netcat-openbsd armhf 1.226-1.1 [42.2 kB] 122s Get:13 http://ftpmaster.internal/ubuntu oracular/main armhf networkd-dispatcher all 2.2.4-1.1 [15.6 kB] 122s Get:14 http://ftpmaster.internal/ubuntu oracular/main armhf rsyslog armhf 8.2406.0-1ubuntu1 [461 kB] 122s Get:15 http://ftpmaster.internal/ubuntu oracular/main armhf systemd-hwe-hwdb all 256.2.1 [3210 B] 122s Get:16 http://ftpmaster.internal/ubuntu oracular/main armhf ubuntu-pro-client-l10n armhf 33.2 [19.2 kB] 122s Get:17 http://ftpmaster.internal/ubuntu oracular/main armhf ubuntu-pro-client armhf 33.2 [232 kB] 122s Get:18 http://ftpmaster.internal/ubuntu oracular/main armhf bind9-dnsutils armhf 1:9.18.28-0ubuntu1 [149 kB] 122s Get:19 http://ftpmaster.internal/ubuntu oracular/main armhf bind9-host armhf 1:9.18.28-0ubuntu1 [47.5 kB] 122s Get:20 http://ftpmaster.internal/ubuntu oracular/main armhf bind9-libs armhf 1:9.18.28-0ubuntu1 [1156 kB] 122s Get:21 http://ftpmaster.internal/ubuntu oracular/main armhf pci.ids all 0.0~2024.06.23-1 [278 kB] 122s Get:22 http://ftpmaster.internal/ubuntu oracular/main armhf strace armhf 6.8-2 [427 kB] 122s Get:23 http://ftpmaster.internal/ubuntu oracular/main armhf libnspr4 armhf 2:4.35-1.1ubuntu1 [93.3 kB] 122s Get:24 http://ftpmaster.internal/ubuntu oracular/main armhf udisks2 armhf 2.10.1-9ubuntu1 [277 kB] 122s Get:25 http://ftpmaster.internal/ubuntu oracular/main armhf libudisks2-0 armhf 2.10.1-9ubuntu1 [142 kB] 122s Get:26 http://ftpmaster.internal/ubuntu oracular/main armhf python3-launchpadlib all 2.0.0-1 [126 kB] 122s Get:27 http://ftpmaster.internal/ubuntu oracular/main armhf cloud-init all 24.3~1g6e4153b3-0ubuntu1 [592 kB] 122s Get:28 http://ftpmaster.internal/ubuntu oracular/main armhf gdisk armhf 1.0.10-2 [229 kB] 122s Get:29 http://ftpmaster.internal/ubuntu oracular/main armhf kpartx armhf 0.9.9-1ubuntu2 [34.6 kB] 122s Get:30 http://ftpmaster.internal/ubuntu oracular/main armhf multipath-tools armhf 0.9.9-1ubuntu2 [292 kB] 122s Preconfiguring packages ... 123s Fetched 6826 kB in 1s (7288 kB/s) 123s (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 ... 58436 files and directories currently installed.) 123s Preparing to unpack .../gcc-14-base_14.1.0-5ubuntu1_armhf.deb ... 123s Unpacking gcc-14-base:armhf (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 123s Setting up gcc-14-base:armhf (14.1.0-5ubuntu1) ... 123s (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 ... 58436 files and directories currently installed.) 123s Preparing to unpack .../libstdc++6_14.1.0-5ubuntu1_armhf.deb ... 123s Unpacking libstdc++6:armhf (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 123s Setting up libstdc++6:armhf (14.1.0-5ubuntu1) ... 123s (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 ... 58436 files and directories currently installed.) 123s Preparing to unpack .../libgcc-s1_14.1.0-5ubuntu1_armhf.deb ... 123s Unpacking libgcc-s1:armhf (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 123s Setting up libgcc-s1:armhf (14.1.0-5ubuntu1) ... 123s (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 ... 58436 files and directories currently installed.) 123s Preparing to unpack .../liblz4-1_1.9.4-3_armhf.deb ... 123s Unpacking liblz4-1:armhf (1.9.4-3) over (1.9.4-2) ... 123s Setting up liblz4-1:armhf (1.9.4-3) ... 123s (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 ... 58436 files and directories currently installed.) 123s Preparing to unpack .../libp11-kit0_0.25.5-2ubuntu1_armhf.deb ... 123s Unpacking libp11-kit0:armhf (0.25.5-2ubuntu1) over (0.25.3-4ubuntu2) ... 123s Setting up libp11-kit0:armhf (0.25.5-2ubuntu1) ... 124s (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 ... 58436 files and directories currently installed.) 124s Preparing to unpack .../00-mawk_1.3.4.20240622-2_armhf.deb ... 124s Unpacking mawk (1.3.4.20240622-2) over (1.3.4.20240622-1) ... 124s Preparing to unpack .../01-libdevmapper1.02.1_2%3a1.02.196-1ubuntu1_armhf.deb ... 124s Unpacking libdevmapper1.02.1:armhf (2:1.02.196-1ubuntu1) over (2:1.02.185-3ubuntu4) ... 124s Preparing to unpack .../02-dmsetup_2%3a1.02.196-1ubuntu1_armhf.deb ... 124s Unpacking dmsetup (2:1.02.196-1ubuntu1) over (2:1.02.185-3ubuntu4) ... 124s Preparing to unpack .../03-libbpf1_1%3a1.4.5-1_armhf.deb ... 124s Unpacking libbpf1:armhf (1:1.4.5-1) over (1:1.4.3-1) ... 124s Preparing to unpack .../04-libxml2_2.12.7+dfsg-3_armhf.deb ... 124s Unpacking libxml2:armhf (2.12.7+dfsg-3) over (2.9.14+dfsg-1.3ubuntu3) ... 124s Preparing to unpack .../05-logrotate_3.22.0-1_armhf.deb ... 124s Unpacking logrotate (3.22.0-1) over (3.21.0-2build1) ... 124s Preparing to unpack .../06-netcat-openbsd_1.226-1.1_armhf.deb ... 124s Unpacking netcat-openbsd (1.226-1.1) over (1.226-1ubuntu2) ... 124s Preparing to unpack .../07-networkd-dispatcher_2.2.4-1.1_all.deb ... 124s Unpacking networkd-dispatcher (2.2.4-1.1) over (2.2.4-1) ... 124s Preparing to unpack .../08-rsyslog_8.2406.0-1ubuntu1_armhf.deb ... 124s Unpacking rsyslog (8.2406.0-1ubuntu1) over (8.2312.0-3ubuntu9) ... 124s Preparing to unpack .../09-systemd-hwe-hwdb_256.2.1_all.deb ... 124s Unpacking systemd-hwe-hwdb (256.2.1) over (255.1.3) ... 124s Preparing to unpack .../10-ubuntu-pro-client-l10n_33.2_armhf.deb ... 124s Unpacking ubuntu-pro-client-l10n (33.2) over (33.1) ... 124s Preparing to unpack .../11-ubuntu-pro-client_33.2_armhf.deb ... 125s Unpacking ubuntu-pro-client (33.2) over (33.1) ... 125s Preparing to unpack .../12-bind9-dnsutils_1%3a9.18.28-0ubuntu1_armhf.deb ... 125s Unpacking bind9-dnsutils (1:9.18.28-0ubuntu1) over (1:9.18.24-0ubuntu5) ... 125s Preparing to unpack .../13-bind9-host_1%3a9.18.28-0ubuntu1_armhf.deb ... 125s Unpacking bind9-host (1:9.18.28-0ubuntu1) over (1:9.18.24-0ubuntu5) ... 125s Preparing to unpack .../14-bind9-libs_1%3a9.18.28-0ubuntu1_armhf.deb ... 125s Unpacking bind9-libs:armhf (1:9.18.28-0ubuntu1) over (1:9.18.24-0ubuntu5) ... 125s Preparing to unpack .../15-pci.ids_0.0~2024.06.23-1_all.deb ... 125s Unpacking pci.ids (0.0~2024.06.23-1) over (0.0~2024.05.31-1) ... 125s Preparing to unpack .../16-strace_6.8-2_armhf.deb ... 125s Unpacking strace (6.8-2) over (6.8-0ubuntu2) ... 125s Preparing to unpack .../17-libnspr4_2%3a4.35-1.1ubuntu1_armhf.deb ... 125s Unpacking libnspr4:armhf (2:4.35-1.1ubuntu1) over (2:4.35-1.1build1) ... 125s Preparing to unpack .../18-udisks2_2.10.1-9ubuntu1_armhf.deb ... 125s Unpacking udisks2 (2.10.1-9ubuntu1) over (2.10.1-9) ... 125s Preparing to unpack .../19-libudisks2-0_2.10.1-9ubuntu1_armhf.deb ... 125s Unpacking libudisks2-0:armhf (2.10.1-9ubuntu1) over (2.10.1-9) ... 125s Preparing to unpack .../20-python3-launchpadlib_2.0.0-1_all.deb ... 125s Unpacking python3-launchpadlib (2.0.0-1) over (1.11.0-6) ... 125s Preparing to unpack .../21-cloud-init_24.3~1g6e4153b3-0ubuntu1_all.deb ... 126s Unpacking cloud-init (24.3~1g6e4153b3-0ubuntu1) over (24.2-0ubuntu1) ... 126s Preparing to unpack .../22-gdisk_1.0.10-2_armhf.deb ... 126s Unpacking gdisk (1.0.10-2) over (1.0.10-1build1) ... 126s Preparing to unpack .../23-kpartx_0.9.9-1ubuntu2_armhf.deb ... 126s Unpacking kpartx (0.9.9-1ubuntu2) over (0.9.4-5ubuntu8) ... 126s Preparing to unpack .../24-multipath-tools_0.9.9-1ubuntu2_armhf.deb ... 126s Unpacking multipath-tools (0.9.9-1ubuntu2) over (0.9.4-5ubuntu8) ... 126s dpkg: warning: unable to delete old directory '/lib/multipath': Directory not empty 126s Setting up logrotate (3.22.0-1) ... 127s logrotate.service is a disabled or a static unit not running, not starting it. 127s Setting up networkd-dispatcher (2.2.4-1.1) ... 128s Setting up pci.ids (0.0~2024.06.23-1) ... 128s Setting up cloud-init (24.3~1g6e4153b3-0ubuntu1) ... 130s Setting up python3-launchpadlib (2.0.0-1) ... 130s Setting up rsyslog (8.2406.0-1ubuntu1) ... 130s info: The user `syslog' is already a member of `adm'. 131s apparmor_parser: Unable to replace "rsyslogd". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 131s 133s Setting up netcat-openbsd (1.226-1.1) ... 133s Setting up gdisk (1.0.10-2) ... 133s Setting up libnspr4:armhf (2:4.35-1.1ubuntu1) ... 133s Setting up strace (6.8-2) ... 133s Setting up systemd-hwe-hwdb (256.2.1) ... 133s Setting up libdevmapper1.02.1:armhf (2:1.02.196-1ubuntu1) ... 133s Setting up dmsetup (2:1.02.196-1ubuntu1) ... 133s Setting up kpartx (0.9.9-1ubuntu2) ... 133s Setting up mawk (1.3.4.20240622-2) ... 133s Setting up libxml2:armhf (2.12.7+dfsg-3) ... 133s Setting up ubuntu-pro-client (33.2) ... 133s Installing new version of config file /etc/apparmor.d/ubuntu_pro_apt_news ... 133s apparmor_parser: Unable to replace "ubuntu_pro_apt_news". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 133s 134s apparmor_parser: Unable to replace "apt_methods". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 134s 134s apparmor_parser: Unable to replace "ubuntu_pro_esm_cache". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 134s 135s Setting up libbpf1:armhf (1:1.4.5-1) ... 135s Setting up libudisks2-0:armhf (2.10.1-9ubuntu1) ... 135s Setting up ubuntu-pro-client-l10n (33.2) ... 135s Setting up udisks2 (2.10.1-9ubuntu1) ... 135s vda: Failed to write 'change' to '/sys/devices/pci0000:00/0000:00:01.3/0000:04:00.0/virtio2/block/vda/uevent': Permission denied 135s vda1: Failed to write 'change' to '/sys/devices/pci0000:00/0000:00:01.3/0000:04:00.0/virtio2/block/vda/vda1/uevent': Permission denied 135s vda15: Failed to write 'change' to '/sys/devices/pci0000:00/0000:00:01.3/0000:04:00.0/virtio2/block/vda/vda15/uevent': Permission denied 135s vda2: Failed to write 'change' to '/sys/devices/pci0000:00/0000:00:01.3/0000:04:00.0/virtio2/block/vda/vda2/uevent': Permission denied 135s loop0: Failed to write 'change' to '/sys/devices/virtual/block/loop0/uevent': Permission denied 135s loop1: Failed to write 'change' to '/sys/devices/virtual/block/loop1/uevent': Permission denied 135s loop2: Failed to write 'change' to '/sys/devices/virtual/block/loop2/uevent': Permission denied 135s loop3: Failed to write 'change' to '/sys/devices/virtual/block/loop3/uevent': Permission denied 135s loop4: Failed to write 'change' to '/sys/devices/virtual/block/loop4/uevent': Permission denied 135s loop5: Failed to write 'change' to '/sys/devices/virtual/block/loop5/uevent': Permission denied 135s loop6: Failed to write 'change' to '/sys/devices/virtual/block/loop6/uevent': Permission denied 135s loop7: Failed to write 'change' to '/sys/devices/virtual/block/loop7/uevent': Permission denied 135s loop8: Failed to write 'change' to '/sys/devices/virtual/block/loop8/uevent': Permission denied 137s Setting up bind9-libs:armhf (1:9.18.28-0ubuntu1) ... 137s Setting up multipath-tools (0.9.9-1ubuntu2) ... 137s Setting up bind9-host (1:9.18.28-0ubuntu1) ... 137s Setting up bind9-dnsutils (1:9.18.28-0ubuntu1) ... 137s Processing triggers for libc-bin (2.39-0ubuntu9) ... 137s Processing triggers for man-db (2.12.1-2) ... 139s Processing triggers for dbus (1.14.10-4ubuntu4) ... 139s Processing triggers for udev (256-1ubuntu1) ... 139s Processing triggers for initramfs-tools (0.142ubuntu30) ... 140s Reading package lists... 141s Building dependency tree... 141s Reading state information... 142s The following packages will be REMOVED: 142s python3-six* 143s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded. 143s After this operation, 59.4 kB disk space will be freed. 143s (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 ... 58436 files and directories currently installed.) 143s Removing python3-six (1.16.0-6) ... 146s autopkgtest [18:26:25]: rebooting testbed after setup commands that affected boot 222s autopkgtest [18:27:41]: testbed running kernel: Linux 6.5.0-41-generic #41~22.04.2-Ubuntu SMP PREEMPT_DYNAMIC Mon Jun 3 16:28:24 UTC 2 249s autopkgtest [18:28:08]: @@@@@@@@@@@@@@@@@@@@ apt-source ruby-timecop 259s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/universe ruby-timecop 0.9.10-1 (dsc) [1517 B] 259s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe ruby-timecop 0.9.10-1 (tar) [20.1 kB] 259s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe ruby-timecop 0.9.10-1 (diff) [3832 B] 259s gpgv: Signature made Tue Jul 23 14:20:15 2024 UTC 259s gpgv: using EDDSA key 84CFFDC21520F88306EC29D152699AB63F9F2BC3 259s gpgv: Can't check signature: No public key 259s dpkg-source: warning: cannot verify inline signature for ./ruby-timecop_0.9.10-1.dsc: no acceptable signature found 259s autopkgtest [18:28:18]: testing package ruby-timecop version 0.9.10-1 261s autopkgtest [18:28:20]: build not needed 263s autopkgtest [18:28:22]: test gem2deb-test-runner: preparing testbed 273s Reading package lists... 273s Building dependency tree... 273s Reading state information... 274s Starting pkgProblemResolver with broken count: 0 274s Starting 2 pkgProblemResolver with broken count: 0 274s Done 275s The following additional packages will be installed: 275s gem2deb-test-runner libruby libruby3.2 rake ruby ruby-activesupport 275s ruby-concurrent ruby-diff-lcs ruby-i18n ruby-metaclass ruby-mocha 275s ruby-net-telnet ruby-rspec ruby-rspec-core ruby-rspec-expectations 275s ruby-rspec-mocks ruby-rspec-support ruby-rubygems ruby-sdbm ruby-timecop 275s ruby-tzinfo ruby-webrick ruby-xmlrpc ruby-zeitwerk ruby3.2 275s rubygems-integration 275s Suggested packages: 275s ri ruby-dev ruby-mocha-doc bundler 275s Recommended packages: 275s zip fonts-lato libjs-jquery 275s The following NEW packages will be installed: 275s autopkgtest-satdep gem2deb-test-runner libruby libruby3.2 rake ruby 275s ruby-activesupport ruby-concurrent ruby-diff-lcs ruby-i18n ruby-metaclass 275s ruby-mocha ruby-net-telnet ruby-rspec ruby-rspec-core 275s ruby-rspec-expectations ruby-rspec-mocks ruby-rspec-support ruby-rubygems 275s ruby-sdbm ruby-timecop ruby-tzinfo ruby-webrick ruby-xmlrpc ruby-zeitwerk 275s ruby3.2 rubygems-integration 275s 0 upgraded, 27 newly installed, 0 to remove and 0 not upgraded. 275s Need to get 6692 kB/6693 kB of archives. 275s After this operation, 31.9 MB of additional disk space will be used. 275s Get:1 /tmp/autopkgtest.seyxSA/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [756 B] 275s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf rubygems-integration all 1.18 [5336 B] 275s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf ruby-net-telnet all 0.2.0-1 [13.3 kB] 275s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf ruby-webrick all 1.8.1-1 [52.3 kB] 275s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf ruby-xmlrpc all 0.3.3-2 [24.8 kB] 276s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf libruby armhf 1:3.2~ubuntu1 [4694 B] 276s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf ruby-sdbm armhf 1.0.0-5build4 [14.0 kB] 276s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf libruby3.2 armhf 3.2.3-1ubuntu1 [5061 kB] 277s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf ruby3.2 armhf 3.2.3-1ubuntu1 [50.6 kB] 277s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf ruby-rubygems all 3.4.20-1 [238 kB] 277s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf ruby armhf 1:3.2~ubuntu1 [3466 B] 277s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf rake all 13.2.1-1 [45.8 kB] 277s Get:13 http://ftpmaster.internal/ubuntu oracular/universe armhf gem2deb-test-runner armhf 2.2.4 [18.2 kB] 277s Get:14 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-concurrent all 1.2.3-2build1 [282 kB] 277s Get:15 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-i18n all 1.14.5-1 [42.5 kB] 277s Get:16 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-tzinfo all 2.0.6-1 [55.2 kB] 277s Get:17 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-zeitwerk all 2.6.8-1 [36.0 kB] 277s Get:18 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-activesupport all 2:6.1.7.3+dfsg-3 [198 kB] 277s Get:19 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-diff-lcs all 1.5.1-1 [22.8 kB] 277s Get:20 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-metaclass all 0.0.4-1.1 [3896 B] 277s Get:21 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-mocha all 1.16.1-3 [140 kB] 277s Get:22 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-rspec-support all 3.13.0c0e0m0s1-2 [29.2 kB] 277s Get:23 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-rspec-core all 3.13.0c0e0m0s1-2 [164 kB] 277s Get:24 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-rspec-expectations all 3.13.0c0e0m0s1-2 [89.8 kB] 277s Get:25 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-rspec-mocks all 3.13.0c0e0m0s1-2 [81.0 kB] 277s Get:26 http://ftpmaster.internal/ubuntu oracular/universe armhf ruby-rspec all 3.13.0c0e0m0s1-2 [3500 B] 277s Get:27 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf ruby-timecop all 0.9.10-1 [11.4 kB] 278s Fetched 6692 kB in 2s (3222 kB/s) 278s Selecting previously unselected package rubygems-integration. 278s (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 ... 58426 files and directories currently installed.) 278s Preparing to unpack .../00-rubygems-integration_1.18_all.deb ... 278s Unpacking rubygems-integration (1.18) ... 278s Selecting previously unselected package ruby-net-telnet. 278s Preparing to unpack .../01-ruby-net-telnet_0.2.0-1_all.deb ... 278s Unpacking ruby-net-telnet (0.2.0-1) ... 278s Selecting previously unselected package ruby-webrick. 278s Preparing to unpack .../02-ruby-webrick_1.8.1-1_all.deb ... 278s Unpacking ruby-webrick (1.8.1-1) ... 278s Selecting previously unselected package ruby-xmlrpc. 278s Preparing to unpack .../03-ruby-xmlrpc_0.3.3-2_all.deb ... 278s Unpacking ruby-xmlrpc (0.3.3-2) ... 278s Selecting previously unselected package libruby:armhf. 278s Preparing to unpack .../04-libruby_1%3a3.2~ubuntu1_armhf.deb ... 278s Unpacking libruby:armhf (1:3.2~ubuntu1) ... 278s Selecting previously unselected package ruby-sdbm:armhf. 278s Preparing to unpack .../05-ruby-sdbm_1.0.0-5build4_armhf.deb ... 278s Unpacking ruby-sdbm:armhf (1.0.0-5build4) ... 278s Selecting previously unselected package libruby3.2:armhf. 278s Preparing to unpack .../06-libruby3.2_3.2.3-1ubuntu1_armhf.deb ... 278s Unpacking libruby3.2:armhf (3.2.3-1ubuntu1) ... 278s Selecting previously unselected package ruby3.2. 278s Preparing to unpack .../07-ruby3.2_3.2.3-1ubuntu1_armhf.deb ... 278s Unpacking ruby3.2 (3.2.3-1ubuntu1) ... 278s Selecting previously unselected package ruby-rubygems. 278s Preparing to unpack .../08-ruby-rubygems_3.4.20-1_all.deb ... 278s Unpacking ruby-rubygems (3.4.20-1) ... 279s Selecting previously unselected package ruby. 279s Preparing to unpack .../09-ruby_1%3a3.2~ubuntu1_armhf.deb ... 279s Unpacking ruby (1:3.2~ubuntu1) ... 279s Selecting previously unselected package rake. 279s Preparing to unpack .../10-rake_13.2.1-1_all.deb ... 279s Unpacking rake (13.2.1-1) ... 279s Selecting previously unselected package gem2deb-test-runner. 279s Preparing to unpack .../11-gem2deb-test-runner_2.2.4_armhf.deb ... 279s Unpacking gem2deb-test-runner (2.2.4) ... 279s Selecting previously unselected package ruby-concurrent. 279s Preparing to unpack .../12-ruby-concurrent_1.2.3-2build1_all.deb ... 279s Unpacking ruby-concurrent (1.2.3-2build1) ... 279s Selecting previously unselected package ruby-i18n. 279s Preparing to unpack .../13-ruby-i18n_1.14.5-1_all.deb ... 279s Unpacking ruby-i18n (1.14.5-1) ... 279s Selecting previously unselected package ruby-tzinfo. 279s Preparing to unpack .../14-ruby-tzinfo_2.0.6-1_all.deb ... 279s Unpacking ruby-tzinfo (2.0.6-1) ... 279s Selecting previously unselected package ruby-zeitwerk. 279s Preparing to unpack .../15-ruby-zeitwerk_2.6.8-1_all.deb ... 279s Unpacking ruby-zeitwerk (2.6.8-1) ... 279s Selecting previously unselected package ruby-activesupport. 279s Preparing to unpack .../16-ruby-activesupport_2%3a6.1.7.3+dfsg-3_all.deb ... 279s Unpacking ruby-activesupport (2:6.1.7.3+dfsg-3) ... 279s Selecting previously unselected package ruby-diff-lcs. 279s Preparing to unpack .../17-ruby-diff-lcs_1.5.1-1_all.deb ... 279s Unpacking ruby-diff-lcs (1.5.1-1) ... 279s Selecting previously unselected package ruby-metaclass. 279s Preparing to unpack .../18-ruby-metaclass_0.0.4-1.1_all.deb ... 279s Unpacking ruby-metaclass (0.0.4-1.1) ... 279s Selecting previously unselected package ruby-mocha. 279s Preparing to unpack .../19-ruby-mocha_1.16.1-3_all.deb ... 279s Unpacking ruby-mocha (1.16.1-3) ... 279s Selecting previously unselected package ruby-rspec-support. 279s Preparing to unpack .../20-ruby-rspec-support_3.13.0c0e0m0s1-2_all.deb ... 279s Unpacking ruby-rspec-support (3.13.0c0e0m0s1-2) ... 279s Selecting previously unselected package ruby-rspec-core. 279s Preparing to unpack .../21-ruby-rspec-core_3.13.0c0e0m0s1-2_all.deb ... 279s Unpacking ruby-rspec-core (3.13.0c0e0m0s1-2) ... 279s Selecting previously unselected package ruby-rspec-expectations. 279s Preparing to unpack .../22-ruby-rspec-expectations_3.13.0c0e0m0s1-2_all.deb ... 279s Unpacking ruby-rspec-expectations (3.13.0c0e0m0s1-2) ... 279s Selecting previously unselected package ruby-rspec-mocks. 279s Preparing to unpack .../23-ruby-rspec-mocks_3.13.0c0e0m0s1-2_all.deb ... 279s Unpacking ruby-rspec-mocks (3.13.0c0e0m0s1-2) ... 279s Selecting previously unselected package ruby-rspec. 279s Preparing to unpack .../24-ruby-rspec_3.13.0c0e0m0s1-2_all.deb ... 279s Unpacking ruby-rspec (3.13.0c0e0m0s1-2) ... 279s Selecting previously unselected package ruby-timecop. 279s Preparing to unpack .../25-ruby-timecop_0.9.10-1_all.deb ... 279s Unpacking ruby-timecop (0.9.10-1) ... 279s Selecting previously unselected package autopkgtest-satdep. 280s Preparing to unpack .../26-1-autopkgtest-satdep.deb ... 280s Unpacking autopkgtest-satdep (0) ... 280s Setting up rubygems-integration (1.18) ... 280s Setting up ruby-concurrent (1.2.3-2build1) ... 280s Setting up ruby-timecop (0.9.10-1) ... 280s Setting up ruby-net-telnet (0.2.0-1) ... 280s Setting up ruby-i18n (1.14.5-1) ... 280s Setting up ruby-rspec-support (3.13.0c0e0m0s1-2) ... 280s Setting up ruby-webrick (1.8.1-1) ... 280s Setting up ruby-xmlrpc (0.3.3-2) ... 280s Setting up ruby-zeitwerk (2.6.8-1) ... 280s Setting up ruby-tzinfo (2.0.6-1) ... 280s Setting up rake (13.2.1-1) ... 280s Setting up libruby:armhf (1:3.2~ubuntu1) ... 280s Setting up ruby-rubygems (3.4.20-1) ... 280s Setting up ruby-sdbm:armhf (1.0.0-5build4) ... 280s Setting up libruby3.2:armhf (3.2.3-1ubuntu1) ... 280s Setting up ruby3.2 (3.2.3-1ubuntu1) ... 280s Setting up ruby (1:3.2~ubuntu1) ... 280s Setting up ruby-rspec-core (3.13.0c0e0m0s1-2) ... 280s Setting up ruby-diff-lcs (1.5.1-1) ... 280s Setting up ruby-metaclass (0.0.4-1.1) ... 280s Setting up ruby-activesupport (2:6.1.7.3+dfsg-3) ... 280s Setting up gem2deb-test-runner (2.2.4) ... 280s Setting up ruby-rspec-expectations (3.13.0c0e0m0s1-2) ... 280s Setting up ruby-mocha (1.16.1-3) ... 280s Setting up ruby-rspec-mocks (3.13.0c0e0m0s1-2) ... 280s Setting up ruby-rspec (3.13.0c0e0m0s1-2) ... 280s Setting up autopkgtest-satdep (0) ... 280s Processing triggers for libc-bin (2.39-0ubuntu9) ... 280s Processing triggers for man-db (2.12.1-2) ... 294s (Reading database ... 62869 files and directories currently installed.) 294s Removing autopkgtest-satdep (0) ... 300s autopkgtest [18:28:59]: test gem2deb-test-runner: gem2deb-test-runner --autopkgtest --check-dependencies 2>&1 300s autopkgtest [18:28:59]: test gem2deb-test-runner: [----------------------- 303s 303s ┌──────────────────────────────────────────────────────────────────────────────┐ 303s │ Checking Rubygems dependency resolution on ruby3.2 │ 303s └──────────────────────────────────────────────────────────────────────────────┘ 303s 303s RUBYLIB=. GEM_PATH= ruby3.2 -e gem\ \"timecop\" 303s mv lib ./.gem2deb.lib 303s mv ./.gem2deb.lib lib 303s 303s ┌──────────────────────────────────────────────────────────────────────────────┐ 303s │ Run tests for ruby3.2 from debian/ruby-tests.rb │ 303s └──────────────────────────────────────────────────────────────────────────────┘ 303s 303s RUBYLIB=. GEM_PATH= ruby3.2 debian/ruby-tests.rb 303s mv lib ./.gem2deb.lib 303s 303s ruby test/time_stack_item_test.rb 303s /usr/share/rubygems-integration/all/gems/activesupport-6.1.7.3/lib/active_support/core_ext/class/subclasses.rb:30: warning: method redefined; discarding old subclasses 303s Run options: --seed 11267 303s 303s # Running: 303s 303s .............................. 303s 303s Finished in 0.067730s, 442.9346 runs/s, 1151.6299 assertions/s. 303s 303s 30 runs, 78 assertions, 0 failures, 0 errors, 0 skips 303s 303s ruby test/timecop_date_parse_freeze_test.rb 304s Run options: --seed 37664 304s 304s # Running: 304s 304s .................................. 304s 304s Finished in 0.011236s, 3025.9965 runs/s, 4449.9948 assertions/s. 304s 304s 34 runs, 50 assertions, 0 failures, 0 errors, 0 skips 304s 304s ruby test/timecop_date_parse_travel_test.rb 304s Run options: --seed 23812 304s 304s # Running: 304s 304s .................................. 304s 304s Finished in 0.017541s, 1938.3007 runs/s, 2850.4422 assertions/s. 304s 304s 34 runs, 50 assertions, 0 failures, 0 errors, 0 skips 304s 304s ruby test/timecop_date_strptime_freeze_test.rb 304s Run options: --seed 29820 304s 304s # Running: 304s 304s S.......................... 304s 304s Finished in 0.140864s, 191.6739 runs/s, 41827.4973 assertions/s. 304s 304s 27 runs, 5892 assertions, 0 failures, 0 errors, 1 skips 304s 304s You have skipped tests. Run with --verbose for details. 304s 304s ruby test/timecop_date_strptime_travel_test.rb 305s Run options: --seed 8130 305s 305s # Running: 305s 305s .......S................... 305s 305s Finished in 0.234645s, 115.0675 runs/s, 25110.2930 assertions/s. 305s 305s 27 runs, 5892 assertions, 0 failures, 0 errors, 1 skips 305s 305s You have skipped tests. Run with --verbose for details. 305s 305s ruby test/timecop_test.rb 305s Run options: --seed 60232 305s 305s # Running: 305s 307s .......................................................................... 307s 307s Finished in 2.039737s, 36.2792 runs/s, 81.8733 assertions/s. 307s 307s 74 runs, 167 assertions, 0 failures, 0 errors, 0 skips 307s 307s ruby test/timecop_with_active_support_test.rb 308s Run options: --seed 16369 308s 308s # Running: 308s 308s . 308s 308s Finished in 0.003066s, 326.1213 runs/s, 326.1213 assertions/s. 308s 308s 1 runs, 1 assertions, 0 failures, 0 errors, 0 skips 308s 308s ruby test/timecop_with_process_clock_test.rb 308s Run options: --seed 47010 308s 308s # Running: 308s 308s ......FF.... 308s 308s Finished in 0.614491s, 19.5284 runs/s, 37.4294 assertions/s. 308s 308s 1) Failure: 308s TestTimecopWithProcessClock#test_process_clock_gettime_realtime [test/timecop_with_process_clock_test.rb:120]: 308s CLOCK_REALTIME is not frozen. 308s Expected 1722018547.5902758 (oid=220) to be the same as 1722018547.5902758 (oid=230). 308s 308s 2) Failure: 308s TestTimecopWithProcessClock#test_process_clock_gettime_monotonic [test/timecop_with_process_clock_test.rb:27]: 308s CLOCK_MONOTONIC is not frozen. 308s Expected 2438962.105122635 (oid=240) to be the same as 2438962.105122635 (oid=250). 308s 308s 12 runs, 23 assertions, 2 failures, 0 errors, 0 skips 308s 308s ruby test/timecop_without_date_but_with_time_test.rb 309s Run options: --seed 8456 309s 309s # Running: 309s 309s . 309s 309s Finished in 0.008553s, 116.9220 runs/s, 0.0000 assertions/s. 309s 309s 1 runs, 0 assertions, 0 failures, 0 errors, 0 skips 309s 309s ruby test/timecop_without_date_test.rb 309s Run options: --seed 37508 309s 309s # Running: 309s 309s ........ 309s 309s Finished in 0.517574s, 15.4567 runs/s, 57.9627 assertions/s. 309s 309s 8 runs, 30 assertions, 0 failures, 0 errors, 0 skips 309s 1 Tests failed 309s ruby test/timecop_with_process_clock_test.rb 309s mv ./.gem2deb.lib lib 310s autopkgtest [18:29:09]: test gem2deb-test-runner: -----------------------] 314s autopkgtest [18:29:13]: test gem2deb-test-runner: - - - - - - - - - - results - - - - - - - - - - 314s gem2deb-test-runner FAIL non-zero exit status 1 318s autopkgtest [18:29:17]: @@@@@@@@@@@@@@@@@@@@ summary 318s gem2deb-test-runner FAIL non-zero exit status 1