0s autopkgtest [14:00:04]: starting date and time: 2025-11-25 14:00:04+0000 0s autopkgtest [14:00:04]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [14:00:04]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.m53r0s79/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ncurses --apt-upgrade gpsd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ncurses/6.5+20251123-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-11.secgroup --name adt-resolute-s390x-gpsd-20251125-140004-juju-7f2275-prod-proposed-migration-environment-15-95aa97e8-a8a7-437f-a58c-50a907682343 --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-s390x-gpsd-20251125-140004-juju-7f2275-prod-proposed-migration-environment-15-95aa97e8-a8a7-437f-a58c-50a907682343 from image adt/ubuntu-resolute-s390x-server-20251125.img (UUID 71778fc2-8550-4588-a39d-8ef712f5a6c0)... 58s autopkgtest [14:01:02]: testbed dpkg architecture: s390x 58s autopkgtest [14:01:02]: testbed apt version: 3.1.12 58s autopkgtest [14:01:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 58s autopkgtest [14:01:02]: testbed release detected to be: None 59s autopkgtest [14:01:03]: updating testbed package index (apt update) 59s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 60s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 60s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 60s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 60s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.4 kB] 60s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9868 B] 60s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [75.7 kB] 60s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [753 kB] 60s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [79.4 kB] 60s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted s390x Packages [1276 B] 60s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [489 kB] 60s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [5944 B] 60s Fetched 1524 kB in 1s (1379 kB/s) 61s Reading package lists... 62s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 62s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 62s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 62s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 62s Reading package lists... 62s Reading package lists... 63s Building dependency tree... 63s Reading state information... 63s Calculating upgrade... 63s The following packages will be upgraded: 63s libncurses6 libncursesw6 libtinfo6 ncurses-base ncurses-bin ncurses-term 63s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 63s Need to get 902 kB of archives. 63s After this operation, 64.5 kB of additional disk space will be used. 63s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x ncurses-bin s390x 6.5+20251123-1 [200 kB] 63s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x ncurses-base all 6.5+20251123-1 [26.2 kB] 63s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x ncurses-term all 6.5+20251123-1 [280 kB] 63s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libncursesw6 s390x 6.5+20251123-1 [157 kB] 63s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libncurses6 s390x 6.5+20251123-1 [121 kB] 63s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libtinfo6 s390x 6.5+20251123-1 [117 kB] 64s dpkg-preconfigure: unable to re-open stdin: No such file or directory 64s Fetched 902 kB in 1s (1264 kB/s) 64s (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 ... 61313 files and directories currently installed.) 64s Preparing to unpack .../ncurses-bin_6.5+20251123-1_s390x.deb ... 64s Unpacking ncurses-bin (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Setting up ncurses-bin (6.5+20251123-1) ... 64s (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 ... 61313 files and directories currently installed.) 64s Preparing to unpack .../ncurses-base_6.5+20251123-1_all.deb ... 64s Unpacking ncurses-base (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Setting up ncurses-base (6.5+20251123-1) ... 64s (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 ... 61313 files and directories currently installed.) 64s Preparing to unpack .../ncurses-term_6.5+20251123-1_all.deb ... 64s Unpacking ncurses-term (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Preparing to unpack .../libncursesw6_6.5+20251123-1_s390x.deb ... 64s Unpacking libncursesw6:s390x (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Preparing to unpack .../libncurses6_6.5+20251123-1_s390x.deb ... 64s Unpacking libncurses6:s390x (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Preparing to unpack .../libtinfo6_6.5+20251123-1_s390x.deb ... 64s Unpacking libtinfo6:s390x (6.5+20251123-1) over (6.5+20250216-2build1) ... 64s Setting up libtinfo6:s390x (6.5+20251123-1) ... 64s Setting up libncurses6:s390x (6.5+20251123-1) ... 64s Setting up libncursesw6:s390x (6.5+20251123-1) ... 64s Setting up ncurses-term (6.5+20251123-1) ... 64s Processing triggers for man-db (2.13.1-1) ... 65s Processing triggers for libc-bin (2.42-2ubuntu2) ... 65s autopkgtest [14:01:09]: upgrading testbed (apt dist-upgrade and autopurge) 65s Reading package lists... 65s Building dependency tree... 65s Reading state information... 65s Calculating upgrade... 65s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 66s Reading package lists... 66s Building dependency tree... 66s Reading state information... 66s Solving dependencies... 66s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 69s autopkgtest [14:01:12]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP Mon Sep 22 08:56:47 UTC 2025 69s autopkgtest [14:01:13]: @@@@@@@@@@@@@@@@@@@@ apt-source gpsd 75s Get:1 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (dsc) [3183 B] 75s Get:2 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (tar) [5225 kB] 75s Get:3 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (asc) [833 B] 75s Get:4 http://ftpmaster.internal/ubuntu resolute/main gpsd 3.25-5ubuntu1 (diff) [53.2 kB] 76s gpgv: Signature made Wed Feb 12 00:48:31 2025 UTC 76s gpgv: using RSA key 5C7ABEA20F8630459CC8C8B5E27F2CF8458C2FA4 76s gpgv: Can't check signature: No public key 76s dpkg-source: warning: cannot verify inline signature for ./gpsd_3.25-5ubuntu1.dsc: no acceptable signature found 76s autopkgtest [14:01:20]: testing package gpsd version 3.25-5ubuntu1 77s autopkgtest [14:01:21]: build not needed 79s autopkgtest [14:01:22]: test check-service: preparing testbed 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Solving dependencies... 79s The following NEW packages will be installed: 79s gpsd libbluetooth3 libgps30t64 79s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 595 kB of archives. 79s After this operation, 1990 kB of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x libgps30t64 s390x 3.25-5ubuntu1 [69.9 kB] 79s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x libbluetooth3 s390x 5.84-1 [77.1 kB] 79s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x gpsd s390x 3.25-5ubuntu1 [448 kB] 80s Fetched 595 kB in 1s (872 kB/s) 80s Selecting previously unselected package libgps30t64:s390x. 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 ... 61332 files and directories currently installed.) 80s Preparing to unpack .../libgps30t64_3.25-5ubuntu1_s390x.deb ... 80s Unpacking libgps30t64:s390x (3.25-5ubuntu1) ... 80s Selecting previously unselected package libbluetooth3:s390x. 80s Preparing to unpack .../libbluetooth3_5.84-1_s390x.deb ... 80s Unpacking libbluetooth3:s390x (5.84-1) ... 80s Selecting previously unselected package gpsd. 80s Preparing to unpack .../gpsd_3.25-5ubuntu1_s390x.deb ... 80s Unpacking gpsd (3.25-5ubuntu1) ... 80s Setting up libgps30t64:s390x (3.25-5ubuntu1) ... 80s Setting up libbluetooth3:s390x (5.84-1) ... 80s Setting up gpsd (3.25-5ubuntu1) ... 80s Creating/updating gpsd user account... 80s Created symlink '/etc/systemd/system/sockets.target.wants/gpsd.socket' → '/usr/lib/systemd/system/gpsd.socket'. 81s gpsd.service is a disabled or a static unit, not starting it. 81s Processing triggers for man-db (2.13.1-1) ... 82s Processing triggers for libc-bin (2.42-2ubuntu2) ... 83s autopkgtest [14:01:27]: test check-service: [----------------------- 83s Check socket being active 83s enabled 83s active 83s Check service being inactive 83s inactive 83s disabled 83s Trying ::1... 83s Connected to localhost. 83s Escape character is '^]'. 83s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 93s {"class":"DEVICES","devices":[]} 93s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 103s {"class":"DEVICES","devices":[]} 103s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 113s simplify test debug - full log 113s Trying ::1... 113s Connected to localhost. 113s Escape character is '^]'. 113s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 113s {"class":"DEVICES","devices":[]} 113s {"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} 113s Check log for version 113s {"class":"VERSION","release":"3.25","rev":"3.25","proto_major":3,"proto_minor":15} 113s Check log for devices 113s {"class":"DEVICES","devices":[]} 113s {"class":"DEVICES","devices":[]} 113s Check log for enabled watch 113s {"class":"WATCH","enable":true,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 113s Check log for disabled watch 113s {"class":"WATCH","enable":false,"json":true,"nmea":false,"raw":0,"scaled":false,"timing":false,"split24":false,"pps":false} 113s Check service being active now 113s active 114s autopkgtest [14:01:58]: test check-service: -----------------------] 114s check-service PASS 114s autopkgtest [14:01:58]: test check-service: - - - - - - - - - - results - - - - - - - - - - 114s autopkgtest [14:01:58]: @@@@@@@@@@@@@@@@@@@@ summary 114s check-service PASS