0s autopkgtest [07:16:46]: starting date and time: 2025-11-19 07:16:46+0000 0s autopkgtest [07:16:46]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [07:16:46]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8b07rt5u/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:systemd,src:dhcpcd --apt-upgrade gpsd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/259~rc1-1ubuntu1 dhcpcd/1:10.3.0-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-10.secgroup --name adt-resolute-amd64-gpsd-20251119-071646-juju-7f2275-prod-proposed-migration-environment-2-926674a7-6631-41fc-a2ee-1d02a028fa07 --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-amd64-gpsd-20251119-071646-juju-7f2275-prod-proposed-migration-environment-2-926674a7-6631-41fc-a2ee-1d02a028fa07 from image adt/ubuntu-resolute-amd64-server-20251119.img (UUID 272731c6-71e6-45e6-858d-225c691169ff)... 46s autopkgtest [07:17:32]: testbed dpkg architecture: amd64 47s autopkgtest [07:17:33]: testbed apt version: 3.1.12 47s autopkgtest [07:17:33]: @@@@@@@@@@@@@@@@@@@@ test bed setup 47s autopkgtest [07:17:33]: testbed release detected to be: None 48s autopkgtest [07:17:34]: updating testbed package index (apt update) 48s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 48s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 48s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 48s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 48s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [67.3 kB] 48s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9848 B] 48s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [823 kB] 49s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.8 kB] 49s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [96.8 kB] 49s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [138 kB] 49s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [3028 B] 49s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [64.9 kB] 49s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [4040 B] 49s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 49s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [556 kB] 49s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [239 kB] 49s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [18.5 kB] 49s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [13.7 kB] 49s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [6880 B] 49s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [680 B] 51s Fetched 2153 kB in 1s (1564 kB/s) 51s Reading package lists... 52s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 52s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 52s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 52s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 52s Reading package lists... 52s Reading package lists... 52s Building dependency tree... 52s Reading state information... 52s Calculating upgrade... 53s The following packages will be upgraded: 53s dhcpcd-base libnss-systemd libpam-systemd libsystemd-shared libsystemd0 53s libudev1 python3-requests systemd systemd-cryptsetup systemd-resolved 53s systemd-sysv udev 53s 12 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 53s Need to get 9041 kB of archives. 53s After this operation, 1782 kB of additional disk space will be used. 53s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libsystemd0 amd64 259~rc1-1ubuntu1 [542 kB] 53s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-sysv amd64 259~rc1-1ubuntu1 [9256 B] 53s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-resolved amd64 259~rc1-1ubuntu1 [298 kB] 53s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libnss-systemd amd64 259~rc1-1ubuntu1 [183 kB] 53s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libpam-systemd amd64 259~rc1-1ubuntu1 [272 kB] 53s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libsystemd-shared amd64 259~rc1-1ubuntu1 [2512 kB] 54s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd amd64 259~rc1-1ubuntu1 [3125 kB] 54s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-cryptsetup amd64 259~rc1-1ubuntu1 [124 kB] 54s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 udev amd64 259~rc1-1ubuntu1 [1483 kB] 54s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libudev1 amd64 259~rc1-1ubuntu1 [212 kB] 54s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 dhcpcd-base amd64 1:10.3.0-1 [228 kB] 54s Get:12 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-requests all 2.32.5+dfsg-1ubuntu1 [53.1 kB] 54s Fetched 9041 kB in 2s (5743 kB/s) 54s dpkg-preconfigure: unable to re-open stdin: No such file or directory 54s (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 ... 82963 files and directories currently installed.) 54s Preparing to unpack .../libsystemd0_259~rc1-1ubuntu1_amd64.deb ... 54s Unpacking libsystemd0:amd64 (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Setting up libsystemd0:amd64 (259~rc1-1ubuntu1) ... 55s (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 ... 82963 files and directories currently installed.) 55s Preparing to unpack .../systemd-sysv_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking systemd-sysv (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../systemd-resolved_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking systemd-resolved (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../libnss-systemd_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking libnss-systemd:amd64 (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../libpam-systemd_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking libpam-systemd:amd64 (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../libsystemd-shared_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking libsystemd-shared:amd64 (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Setting up libsystemd-shared:amd64 (259~rc1-1ubuntu1) ... 55s (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 ... 82962 files and directories currently installed.) 55s Preparing to unpack .../systemd_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking systemd (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../systemd-cryptsetup_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking systemd-cryptsetup (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../udev_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking udev (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Preparing to unpack .../libudev1_259~rc1-1ubuntu1_amd64.deb ... 55s Unpacking libudev1:amd64 (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 55s Setting up libudev1:amd64 (259~rc1-1ubuntu1) ... 55s (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 ... 83045 files and directories currently installed.) 55s Preparing to unpack .../dhcpcd-base_1%3a10.3.0-1_amd64.deb ... 55s Unpacking dhcpcd-base (1:10.3.0-1) over (1:10.2.4-4) ... 55s Preparing to unpack .../python3-requests_2.32.5+dfsg-1ubuntu1_all.deb ... 55s Unpacking python3-requests (2.32.5+dfsg-1ubuntu1) over (2.32.3+dfsg-5ubuntu2) ... 55s Setting up systemd (259~rc1-1ubuntu1) ... 55s Installing new version of config file /etc/systemd/journald.conf ... 55s Installing new version of config file /etc/systemd/logind.conf ... 55s Installing new version of config file /etc/systemd/networkd.conf ... 55s Installing new version of config file /etc/systemd/system.conf ... 55s Installing new version of config file /etc/systemd/user.conf ... 55s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 55s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 56s Setting up systemd-cryptsetup (259~rc1-1ubuntu1) ... 56s Setting up python3-requests (2.32.5+dfsg-1ubuntu1) ... 56s Setting up udev (259~rc1-1ubuntu1) ... 57s Setting up dhcpcd-base (1:10.3.0-1) ... 57s Installing new version of config file /etc/dhcpcd.conf ... 57s Creating group 'dhcpcd' with GID 986. 57s Setting up systemd-resolved (259~rc1-1ubuntu1) ... 57s Installing new version of config file /etc/systemd/resolved.conf ... 57s Created symlink '/etc/systemd/system/sockets.target.wants/systemd-resolved-monitor.socket' → '/usr/lib/systemd/system/systemd-resolved-monitor.socket'. 57s Created symlink '/etc/systemd/system/sockets.target.wants/systemd-resolved-varlink.socket' → '/usr/lib/systemd/system/systemd-resolved-varlink.socket'. 57s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 57s Setting up systemd-sysv (259~rc1-1ubuntu1) ... 57s Setting up libnss-systemd:amd64 (259~rc1-1ubuntu1) ... 57s Setting up libpam-systemd:amd64 (259~rc1-1ubuntu1) ... 57s Processing triggers for libc-bin (2.42-2ubuntu2) ... 57s Processing triggers for man-db (2.13.1-1) ... 58s Processing triggers for dbus (1.16.2-2ubuntu2) ... 58s Processing triggers for shared-mime-info (2.4-5build2) ... 59s Processing triggers for procps (2:4.0.4-8ubuntu3) ... 59s Processing triggers for initramfs-tools (0.150ubuntu5) ... 60s update-initramfs: Generating /boot/initrd.img-6.17.0-5-generic 64s autopkgtest [07:17:50]: upgrading testbed (apt dist-upgrade and autopurge) 64s Reading package lists... 64s Building dependency tree... 64s Reading state information... 64s Calculating upgrade... 64s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 64s Reading package lists... 64s Building dependency tree... 64s Reading state information... 65s Solving dependencies... 65s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 65s autopkgtest [07:17:51]: rebooting testbed after setup commands that affected boot 93s autopkgtest [07:18:19]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 96s autopkgtest [07:18:22]: @@@@@@@@@@@@@@@@@@@@ apt-source gpsd 100s Get:1 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (dsc) [3183 B] 100s Get:2 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (tar) [5225 kB] 100s Get:3 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (asc) [833 B] 100s Get:4 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (diff) [53.2 kB] 100s gpgv: Signature made Wed Feb 12 00:48:31 2025 UTC 100s gpgv: using RSA key 5C7ABEA20F8630459CC8C8B5E27F2CF8458C2FA4 100s gpgv: Can't check signature: No public key 100s dpkg-source: warning: cannot verify inline signature for ./gpsd_3.25-5ubuntu1.dsc: no acceptable signature found 100s autopkgtest [07:18:26]: testing package gpsd version 3.25-5ubuntu1 101s autopkgtest [07:18:27]: build not needed 104s autopkgtest [07:18:30]: test check-service: preparing testbed 104s Reading package lists... 104s Building dependency tree... 104s Reading state information... 104s Solving dependencies... 104s The following NEW packages will be installed: 104s gpsd libbluetooth3 libgps30t64 104s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 104s Need to get 572 kB of archives. 104s After this operation, 1933 kB of additional disk space will be used. 104s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 libgps30t64 amd64 3.25-5ubuntu1 [65.5 kB] 104s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 libbluetooth3 amd64 5.84-1 [79.3 kB] 104s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 gpsd amd64 3.25-5ubuntu1 [428 kB] 104s Fetched 572 kB in 0s (2223 kB/s) 104s Selecting previously unselected package libgps30t64:amd64. 105s (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 ... 83046 files and directories currently installed.) 105s Preparing to unpack .../libgps30t64_3.25-5ubuntu1_amd64.deb ... 105s Unpacking libgps30t64:amd64 (3.25-5ubuntu1) ... 105s Selecting previously unselected package libbluetooth3:amd64. 105s Preparing to unpack .../libbluetooth3_5.84-1_amd64.deb ... 105s Unpacking libbluetooth3:amd64 (5.84-1) ... 105s Selecting previously unselected package gpsd. 105s Preparing to unpack .../gpsd_3.25-5ubuntu1_amd64.deb ... 105s Unpacking gpsd (3.25-5ubuntu1) ... 105s Setting up libgps30t64:amd64 (3.25-5ubuntu1) ... 105s Setting up libbluetooth3:amd64 (5.84-1) ... 105s Setting up gpsd (3.25-5ubuntu1) ... 105s Creating/updating gpsd user account... 105s Created symlink '/etc/systemd/system/sockets.target.wants/gpsd.socket' → '/usr/lib/systemd/system/gpsd.socket'. 106s gpsd.service is a disabled or a static unit, not starting it. 106s Processing triggers for man-db (2.13.1-1) ... 106s Processing triggers for libc-bin (2.42-2ubuntu2) ... 107s autopkgtest [07:18:33]: test check-service: [----------------------- 107s Check socket being active 107s enabled 107s active 107s Check service being inactive 107s inactive 107s disabled 107s Trying ::1... 107s Connected to localhost. 107s Escape character is '^]'. 107s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 117s {"class":"DEVICES","devices":[]} 117s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 127s {"class":"DEVICES","devices":[]} 127s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 137s simplify test debug - full log 137s Trying ::1... 137s Connected to localhost. 137s Escape character is '^]'. 137s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 137s {"class":"DEVICES","devices":[]} 137s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 137s {"class":"DEVICES","devices":[]} 137s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 137s Check log for version 137s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 137s Check log for devices 137s {"class":"DEVICES","devices":[]} 137s {"class":"DEVICES","devices":[]} 137s Check log for enabled watch 137s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 137s Check log for disabled watch 137s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 137s Check service being active now 137s active 138s autopkgtest [07:19:04]: test check-service: -----------------------] 138s check-service PASS 138s autopkgtest [07:19:04]: test check-service: - - - - - - - - - - results - - - - - - - - - - 138s autopkgtest [07:19:04]: @@@@@@@@@@@@@@@@@@@@ summary 138s check-service PASS