0s autopkgtest [20:06:27]: starting date and time: 2024-11-15 20:06:27+0000 0s autopkgtest [20:06:27]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [20:06:27]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.655v_27p/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:systemd,src:openssh --apt-upgrade gpsd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/255.4-1ubuntu8.5 openssh/1:9.6p1-3ubuntu13.7' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-19.secgroup --name adt-noble-arm64-gpsd-20241115-200626-juju-7f2275-prod-proposed-migration-environment-2-ac827f8e-2fae-4ffa-9d8f-ef47afdf7d05 --image adt/ubuntu-noble-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 67s autopkgtest [20:07:34]: testbed dpkg architecture: arm64 67s autopkgtest [20:07:34]: testbed apt version: 2.7.14build2 67s autopkgtest [20:07:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 68s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 68s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [88.3 kB] 69s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [78.5 kB] 69s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [3240 B] 69s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [185 kB] 69s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3756 B] 69s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [69.3 kB] 69s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [352 B] 69s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [617 kB] 69s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [9620 B] 69s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [344 B] 71s Fetched 1321 kB in 1s (1131 kB/s) 71s Reading package lists... 74s Reading package lists... 75s Building dependency tree... 75s Reading state information... 76s Calculating upgrade... 76s The following packages will be upgraded: 76s libnss-systemd libpam-systemd libsystemd-shared libsystemd0 libudev1 76s openssh-client openssh-server openssh-sftp-server systemd systemd-dev 76s systemd-resolved systemd-sysv systemd-timesyncd udev 76s 14 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 76s Need to get 10.1 MB of archives. 76s After this operation, 66.6 kB of additional disk space will be used. 76s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libnss-systemd arm64 255.4-1ubuntu8.5 [155 kB] 77s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-dev all 255.4-1ubuntu8.5 [104 kB] 77s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-timesyncd arm64 255.4-1ubuntu8.5 [34.8 kB] 77s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-resolved arm64 255.4-1ubuntu8.5 [291 kB] 77s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd-shared arm64 255.4-1ubuntu8.5 [2017 kB] 77s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd0 arm64 255.4-1ubuntu8.5 [425 kB] 77s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-sysv arm64 255.4-1ubuntu8.5 [11.9 kB] 77s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libpam-systemd arm64 255.4-1ubuntu8.5 [232 kB] 78s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd arm64 255.4-1ubuntu8.5 [3404 kB] 78s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 udev arm64 255.4-1ubuntu8.5 [1852 kB] 78s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libudev1 arm64 255.4-1ubuntu8.5 [173 kB] 78s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-sftp-server arm64 1:9.6p1-3ubuntu13.7 [36.8 kB] 78s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-server arm64 1:9.6p1-3ubuntu13.7 [501 kB] 78s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-client arm64 1:9.6p1-3ubuntu13.7 [887 kB] 79s Preconfiguring packages ... 79s Fetched 10.1 MB in 2s (4319 kB/s) 80s (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 ... 78121 files and directories currently installed.) 80s Preparing to unpack .../0-libnss-systemd_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking libnss-systemd:arm64 (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../1-systemd-dev_255.4-1ubuntu8.5_all.deb ... 80s Unpacking systemd-dev (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../2-systemd-timesyncd_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking systemd-timesyncd (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../3-systemd-resolved_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking systemd-resolved (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../4-libsystemd-shared_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking libsystemd-shared:arm64 (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../5-libsystemd0_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking libsystemd0:arm64 (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Setting up libsystemd0:arm64 (255.4-1ubuntu8.5) ... 80s (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 ... 78121 files and directories currently installed.) 80s Preparing to unpack .../systemd-sysv_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking systemd-sysv (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../libpam-systemd_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking libpam-systemd:arm64 (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 80s Preparing to unpack .../systemd_255.4-1ubuntu8.5_arm64.deb ... 80s Unpacking systemd (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 81s Preparing to unpack .../udev_255.4-1ubuntu8.5_arm64.deb ... 81s Unpacking udev (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 81s Preparing to unpack .../libudev1_255.4-1ubuntu8.5_arm64.deb ... 81s Unpacking libudev1:arm64 (255.4-1ubuntu8.5) over (255.4-1ubuntu8.4) ... 81s Setting up libudev1:arm64 (255.4-1ubuntu8.5) ... 81s (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 ... 78121 files and directories currently installed.) 81s Preparing to unpack .../openssh-sftp-server_1%3a9.6p1-3ubuntu13.7_arm64.deb ... 81s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu13.7) over (1:9.6p1-3ubuntu13.5) ... 81s Preparing to unpack .../openssh-server_1%3a9.6p1-3ubuntu13.7_arm64.deb ... 81s Unpacking openssh-server (1:9.6p1-3ubuntu13.7) over (1:9.6p1-3ubuntu13.5) ... 81s Preparing to unpack .../openssh-client_1%3a9.6p1-3ubuntu13.7_arm64.deb ... 81s Unpacking openssh-client (1:9.6p1-3ubuntu13.7) over (1:9.6p1-3ubuntu13.5) ... 82s Setting up openssh-client (1:9.6p1-3ubuntu13.7) ... 82s Setting up systemd-dev (255.4-1ubuntu8.5) ... 82s Setting up libsystemd-shared:arm64 (255.4-1ubuntu8.5) ... 82s Setting up openssh-sftp-server (1:9.6p1-3ubuntu13.7) ... 82s Setting up openssh-server (1:9.6p1-3ubuntu13.7) ... 82s Replacing config file /etc/ssh/sshd_config with new version 83s Setting up systemd (255.4-1ubuntu8.5) ... 84s Setting up systemd-timesyncd (255.4-1ubuntu8.5) ... 85s Setting up udev (255.4-1ubuntu8.5) ... 86s Setting up systemd-resolved (255.4-1ubuntu8.5) ... 86s Setting up systemd-sysv (255.4-1ubuntu8.5) ... 86s Setting up libnss-systemd:arm64 (255.4-1ubuntu8.5) ... 86s Setting up libpam-systemd:arm64 (255.4-1ubuntu8.5) ... 87s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 87s Processing triggers for ufw (0.36.2-6) ... 87s Processing triggers for man-db (2.12.0-4build2) ... 88s Processing triggers for dbus (1.14.10-4ubuntu4.1) ... 88s Processing triggers for initramfs-tools (0.142ubuntu25.4) ... 89s update-initramfs: Generating /boot/initrd.img-6.8.0-48-generic 89s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 112s System running in EFI mode, skipping. 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 113s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 113s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 113s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 115s Reading package lists... 115s Reading package lists... 115s Building dependency tree... 115s Reading state information... 116s Calculating upgrade... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Reading package lists... 117s Building dependency tree... 117s Reading state information... 118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 118s autopkgtest [20:08:25]: rebooting testbed after setup commands that affected boot 122s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 144s autopkgtest [20:08:51]: testbed running kernel: Linux 6.8.0-48-generic #48-Ubuntu SMP PREEMPT_DYNAMIC Fri Sep 27 14:35:45 UTC 2024 147s autopkgtest [20:08:54]: @@@@@@@@@@@@@@@@@@@@ apt-source gpsd 153s Get:1 http://ftpmaster.internal/ubuntu noble/main gpsd 3.25-3ubuntu3 (dsc) [3200 B] 153s Get:2 http://ftpmaster.internal/ubuntu noble/main gpsd 3.25-3ubuntu3 (tar) [5225 kB] 153s Get:3 http://ftpmaster.internal/ubuntu noble/main gpsd 3.25-3ubuntu3 (asc) [833 B] 153s Get:4 http://ftpmaster.internal/ubuntu noble/main gpsd 3.25-3ubuntu3 (diff) [48.2 kB] 153s gpgv: Signature made Sun Mar 31 07:36:21 2024 UTC 153s gpgv: using RSA key AC483F68DE728F43F2202FCA568D30F321B2133D 153s gpgv: issuer "steve.langasek@ubuntu.com" 153s gpgv: Can't check signature: No public key 153s dpkg-source: warning: cannot verify inline signature for ./gpsd_3.25-3ubuntu3.dsc: no acceptable signature found 154s autopkgtest [20:09:01]: testing package gpsd version 3.25-3ubuntu3 154s autopkgtest [20:09:01]: build not needed 156s autopkgtest [20:09:03]: test check-service: preparing testbed 157s Reading package lists... 158s Building dependency tree... 158s Reading state information... 158s Starting pkgProblemResolver with broken count: 0 158s Starting 2 pkgProblemResolver with broken count: 0 158s Done 159s The following additional packages will be installed: 159s gpsd libbluetooth3 libgps30t64 159s Suggested packages: 159s gpsd-clients 159s Recommended packages: 159s gpsd-tools 159s The following NEW packages will be installed: 159s autopkgtest-satdep gpsd libbluetooth3 libgps30t64 159s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 159s Need to get 594 kB/595 kB of archives. 159s After this operation, 2322 kB of additional disk space will be used. 159s Get:1 /tmp/autopkgtest.VfxijX/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [720 B] 159s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libgps30t64 arm64 3.25-3ubuntu3 [74.7 kB] 159s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 libbluetooth3 arm64 5.72-0ubuntu5 [93.5 kB] 159s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 gpsd arm64 3.25-3ubuntu3 [426 kB] 160s Fetched 594 kB in 0s (1215 kB/s) 160s Selecting previously unselected package libgps30t64:arm64. 160s (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 ... 78121 files and directories currently installed.) 160s Preparing to unpack .../libgps30t64_3.25-3ubuntu3_arm64.deb ... 160s Unpacking libgps30t64:arm64 (3.25-3ubuntu3) ... 160s Selecting previously unselected package libbluetooth3:arm64. 160s Preparing to unpack .../libbluetooth3_5.72-0ubuntu5_arm64.deb ... 160s Unpacking libbluetooth3:arm64 (5.72-0ubuntu5) ... 160s Selecting previously unselected package gpsd. 160s Preparing to unpack .../gpsd_3.25-3ubuntu3_arm64.deb ... 160s Unpacking gpsd (3.25-3ubuntu3) ... 160s Selecting previously unselected package autopkgtest-satdep. 160s Preparing to unpack .../1-autopkgtest-satdep.deb ... 160s Unpacking autopkgtest-satdep (0) ... 160s Setting up libgps30t64:arm64 (3.25-3ubuntu3) ... 160s Setting up libbluetooth3:arm64 (5.72-0ubuntu5) ... 160s Setting up gpsd (3.25-3ubuntu3) ... 160s Creating/updating gpsd user account... 160s Created symlink /etc/systemd/system/sockets.target.wants/gpsd.socket → /usr/lib/systemd/system/gpsd.socket. 162s gpsd.service is a disabled or a static unit, not starting it. 162s Setting up autopkgtest-satdep (0) ... 162s Processing triggers for man-db (2.12.0-4build2) ... 163s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 166s (Reading database ... 78165 files and directories currently installed.) 166s Removing autopkgtest-satdep (0) ... 167s autopkgtest [20:09:14]: test check-service: [----------------------- 167s Check socket being active 167s enabled 167s active 167s Check service being inactive 167s inactive 167s disabled 167s Trying ::1... 167s Connected to localhost. 167s Escape character is '^]'. 168s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 178s {"class":"DEVICES","devices":[]} 178s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 188s {"class":"DEVICES","devices":[]} 188s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 198s simplify test debug - full log 198s Trying ::1... 198s Connected to localhost. 198s Escape character is '^]'. 198s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 198s {"class":"DEVICES","devices":[]} 198s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 198s {"class":"DEVICES","devices":[]} 198s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 198s Check log for version 198s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 198s Check log for devices 198s {"class":"DEVICES","devices":[]} 198s {"class":"DEVICES","devices":[]} 198s Check log for enabled watch 198s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 198s Check log for disabled watch 198s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 198s Check service being active now 198s active 198s autopkgtest [20:09:45]: test check-service: -----------------------] 198s autopkgtest [20:09:45]: test check-service: - - - - - - - - - - results - - - - - - - - - - 198s check-service PASS 199s autopkgtest [20:09:46]: @@@@@@@@@@@@@@@@@@@@ summary 199s check-service PASS 211s virt: nova [W] Skipping flock in bos03-arm64 211s virt: Creating nova instance adt-noble-arm64-gpsd-20241115-200626-juju-7f2275-prod-proposed-migration-environment-2-ac827f8e-2fae-4ffa-9d8f-ef47afdf7d05 from image adt/ubuntu-noble-arm64-server-20241115.img (UUID 7f368af9-0e77-4513-8b13-cc742bdc3388)...