0s autopkgtest [18:29:25]: starting date and time: 2025-12-02 18:29:25+0000 0s autopkgtest [18:29:25]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [18:29:25]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.z50fgsta/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:inetutils --apt-upgrade gpsd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=inetutils/2:2.6-4ubuntu1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-8.secgroup --name adt-resolute-s390x-gpsd-20251202-182925-juju-7f2275-prod-proposed-migration-environment-20-537e7ed9-d350-47b8-9094-31e82fafc286 --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-s390x-gpsd-20251202-182925-juju-7f2275-prod-proposed-migration-environment-20-537e7ed9-d350-47b8-9094-31e82fafc286 from image adt/ubuntu-resolute-s390x-server-20251201.img (UUID 8b543b6a-e578-44a2-9fed-51cc5e2754ca)... 46s autopkgtest [18:30:11]: testbed dpkg architecture: s390x 46s autopkgtest [18:30:11]: testbed apt version: 3.1.12 46s autopkgtest [18:30:11]: @@@@@@@@@@@@@@@@@@@@ test bed setup 46s autopkgtest [18:30:11]: testbed release detected to be: None 47s autopkgtest [18:30:12]: updating testbed package index (apt update) 47s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 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/multiverse Sources [20.5 kB] 48s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [844 kB] 48s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [140 kB] 48s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [121 kB] 48s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [536 kB] 48s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [5932 B] 48s Fetched 1791 kB in 1s (1621 kB/s) 49s Reading package lists... 50s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 50s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 50s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 50s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 51s Reading package lists... 51s Reading package lists... 51s Building dependency tree... 51s Reading state information... 51s Calculating upgrade... 51s The following packages will be upgraded: 51s bcache-tools inetutils-telnet telnet 53s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 53s Need to get 136 kB of archives. 53s After this operation, 3072 B disk space will be freed. 53s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x inetutils-telnet s390x 2:2.6-4ubuntu1 [112 kB] 55s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x telnet all 0.17+2.6-4ubuntu1 [3644 B] 55s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x bcache-tools s390x 1.0.8-5build2 [20.1 kB] 55s dpkg-preconfigure: unable to re-open stdin: No such file or directory 55s Fetched 136 kB in 4s (32.9 kB/s) 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 ... 87031 files and directories currently installed.) 55s Preparing to unpack .../inetutils-telnet_2%3a2.6-4ubuntu1_s390x.deb ... 55s Unpacking inetutils-telnet (2:2.6-4ubuntu1) over (2:2.6-1ubuntu3) ... 55s Preparing to unpack .../telnet_0.17+2.6-4ubuntu1_all.deb ... 55s Unpacking telnet (0.17+2.6-4ubuntu1) over (0.17+2.6-1ubuntu3) ... 55s Preparing to unpack .../bcache-tools_1.0.8-5build2_s390x.deb ... 55s Unpacking bcache-tools (1.0.8-5build2) over (1.0.8-5build1) ... 55s Setting up bcache-tools (1.0.8-5build2) ... 56s Setting up inetutils-telnet (2:2.6-4ubuntu1) ... 56s Setting up telnet (0.17+2.6-4ubuntu1) ... 56s Processing triggers for man-db (2.13.1-1) ... 56s Processing triggers for initramfs-tools (0.150ubuntu5) ... 56s update-initramfs: Generating /boot/initrd.img-6.17.0-6-generic 59s Using config file '/etc/zipl.conf' 59s Building bootmap in '/boot' 59s Adding IPL section 'ubuntu' (default) 59s Preparing boot device for LD-IPL: vda (0000). 59s Done. 60s autopkgtest [18:30:25]: upgrading testbed (apt dist-upgrade and autopurge) 60s Reading package lists... 60s Building dependency tree... 60s Reading state information... 60s Calculating upgrade... 60s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 60s Reading package lists... 60s Building dependency tree... 60s Reading state information... 61s Solving dependencies... 61s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 61s autopkgtest [18:30:26]: rebooting testbed after setup commands that affected boot 76s autopkgtest [18:30:41]: testbed running kernel: Linux 6.17.0-6-generic #6-Ubuntu SMP Tue Oct 7 12:36:22 UTC 2025 78s autopkgtest [18:30:43]: @@@@@@@@@@@@@@@@@@@@ apt-source gpsd 85s Get:1 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (dsc) [3183 B] 85s Get:2 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (tar) [5225 kB] 85s Get:3 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (asc) [833 B] 85s Get:4 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (diff) [53.2 kB] 85s gpgv: Signature made Wed Feb 12 00:48:31 2025 UTC 85s gpgv: using RSA key 5C7ABEA20F8630459CC8C8B5E27F2CF8458C2FA4 85s gpgv: Can't check signature: No public key 85s dpkg-source: warning: cannot verify inline signature for ./gpsd_3.25-5ubuntu1.dsc: no acceptable signature found 85s autopkgtest [18:30:50]: testing package gpsd version 3.25-5ubuntu1 86s autopkgtest [18:30:51]: build not needed 88s autopkgtest [18:30:53]: test check-service: preparing testbed 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 89s Solving dependencies... 89s The following NEW packages will be installed: 89s gpsd libbluetooth3 libgps30t64 89s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 89s Need to get 595 kB of archives. 89s After this operation, 1990 kB of additional disk space will be used. 89s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x libgps30t64 s390x 3.25-5ubuntu1 [69.9 kB] 89s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x libbluetooth3 s390x 5.84-1 [77.1 kB] 89s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x gpsd s390x 3.25-5ubuntu1 [448 kB] 90s Fetched 595 kB in 1s (654 kB/s) 90s Selecting previously unselected package libgps30t64:s390x. 90s (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 ... 87031 files and directories currently installed.) 90s Preparing to unpack .../libgps30t64_3.25-5ubuntu1_s390x.deb ... 90s Unpacking libgps30t64:s390x (3.25-5ubuntu1) ... 90s Selecting previously unselected package libbluetooth3:s390x. 90s Preparing to unpack .../libbluetooth3_5.84-1_s390x.deb ... 90s Unpacking libbluetooth3:s390x (5.84-1) ... 90s Selecting previously unselected package gpsd. 90s Preparing to unpack .../gpsd_3.25-5ubuntu1_s390x.deb ... 90s Unpacking gpsd (3.25-5ubuntu1) ... 90s Setting up libgps30t64:s390x (3.25-5ubuntu1) ... 90s Setting up libbluetooth3:s390x (5.84-1) ... 90s Setting up gpsd (3.25-5ubuntu1) ... 90s Creating/updating gpsd user account... 90s Created symlink '/etc/systemd/system/sockets.target.wants/gpsd.socket' → '/usr/lib/systemd/system/gpsd.socket'. 91s gpsd.service is a disabled or a static unit, not starting it. 91s Processing triggers for man-db (2.13.1-1) ... 92s Processing triggers for libc-bin (2.42-2ubuntu2) ... 93s autopkgtest [18:30:58]: test check-service: [----------------------- 93s Check socket being active 93s enabled 93s active 93s Check service being inactive 93s inactive 93s disabled 93s Trying ::1... 93s Connected to localhost. 93s Escape character is '^]'. 93s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 103s {"class":"DEVICES","devices":[]} 103s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 113s {"class":"DEVICES","devices":[]} 113s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 123s simplify test debug - full log 123s Trying ::1... 123s Connected to localhost. 123s Escape character is '^]'. 123s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 123s {"class":"DEVICES","devices":[]} 123s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 123s {"class":"DEVICES","devices":[]} 123s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 123s Check log for version 123s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 123s Check log for devices 123s {"class":"DEVICES","devices":[]} 123s {"class":"DEVICES","devices":[]} 123s Check log for enabled watch 123s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 123s Check log for disabled watch 123s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 123s Check service being active now 123s active 123s autopkgtest [18:31:28]: test check-service: -----------------------] 124s autopkgtest [18:31:29]: test check-service: - - - - - - - - - - results - - - - - - - - - - 124s check-service PASS 124s autopkgtest [18:31:29]: @@@@@@@@@@@@@@@@@@@@ summary 124s check-service PASS