0s autopkgtest [22:55:45]: starting date and time: 2025-05-04 22:55:45+0000 0s autopkgtest [22:55:45]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [22:55:45]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.pbrerh10/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:libzstd --apt-upgrade wyrd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=libzstd/1.5.7+dfsg-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-ppc64el-4.secgroup --name adt-questing-ppc64el-wyrd-20250504-225545-juju-7f2275-prod-proposed-migration-environment-20-2d6bcdd2-35a8-4e6e-97fd-c4194acba18f --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 71s autopkgtest [22:56:56]: testbed dpkg architecture: ppc64el 71s autopkgtest [22:56:56]: testbed apt version: 3.0.0 71s autopkgtest [22:56:56]: @@@@@@@@@@@@@@@@@@@@ test bed setup 71s autopkgtest [22:56:56]: testbed release detected to be: None 72s autopkgtest [22:56:57]: updating testbed package index (apt update) 72s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 72s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 72s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 72s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 72s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [110 kB] 72s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [33.2 kB] 72s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [1078 kB] 73s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [148 kB] 73s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [1052 kB] 73s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [31.0 kB] 73s Fetched 2562 kB in 1s (3384 kB/s) 74s Reading package lists... 74s autopkgtest [22:56:59]: upgrading testbed (apt dist-upgrade and autopurge) 74s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 75s Starting 2 pkgProblemResolver with broken count: 0 75s Done 75s Entering ResolveByKeep 75s 75s Calculating upgrade... 76s The following packages will be upgraded: 76s libbpf1 libperl5.40 libusb-1.0-0 libzstd1 perl perl-base perl-modules-5.40 76s zstd 76s 8 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 76s Need to get 11.9 MB of archives. 76s After this operation, 63.5 kB disk space will be freed. 76s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libperl5.40 ppc64el 5.40.1-3 [4949 kB] 76s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el perl ppc64el 5.40.1-3 [262 kB] 76s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el perl-base ppc64el 5.40.1-3 [1923 kB] 76s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el perl-modules-5.40 all 5.40.1-3 [3217 kB] 76s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libzstd1 ppc64el 1.5.7+dfsg-1 [410 kB] 76s Get:6 http://ftpmaster.internal/ubuntu questing/main ppc64el libbpf1 ppc64el 1:1.5.0-3 [231 kB] 76s Get:7 http://ftpmaster.internal/ubuntu questing/main ppc64el libusb-1.0-0 ppc64el 2:1.0.28-1 [64.4 kB] 76s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el zstd ppc64el 1.5.7+dfsg-1 [811 kB] 77s Fetched 11.9 MB in 1s (22.4 MB/s) 78s (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 ... 78710 files and directories currently installed.) 78s Preparing to unpack .../libperl5.40_5.40.1-3_ppc64el.deb ... 78s Unpacking libperl5.40:ppc64el (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 79s Preparing to unpack .../perl_5.40.1-3_ppc64el.deb ... 79s Unpacking perl (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 79s Preparing to unpack .../perl-base_5.40.1-3_ppc64el.deb ... 79s Unpacking perl-base (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 79s Setting up perl-base (5.40.1-3) ... 79s (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 ... 78710 files and directories currently installed.) 79s Preparing to unpack .../perl-modules-5.40_5.40.1-3_all.deb ... 79s Unpacking perl-modules-5.40 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 80s Preparing to unpack .../libzstd1_1.5.7+dfsg-1_ppc64el.deb ... 80s Unpacking libzstd1:ppc64el (1.5.7+dfsg-1) over (1.5.6+dfsg-2) ... 80s Setting up libzstd1:ppc64el (1.5.7+dfsg-1) ... 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 ... 78710 files and directories currently installed.) 80s Preparing to unpack .../libbpf1_1%3a1.5.0-3_ppc64el.deb ... 80s Unpacking libbpf1:ppc64el (1:1.5.0-3) over (1:1.5.0-2) ... 80s Preparing to unpack .../libusb-1.0-0_2%3a1.0.28-1_ppc64el.deb ... 80s Unpacking libusb-1.0-0:ppc64el (2:1.0.28-1) over (2:1.0.27-2) ... 80s Preparing to unpack .../zstd_1.5.7+dfsg-1_ppc64el.deb ... 80s Unpacking zstd (1.5.7+dfsg-1) over (1.5.6+dfsg-2) ... 80s Setting up perl-modules-5.40 (5.40.1-3) ... 80s Setting up libusb-1.0-0:ppc64el (2:1.0.28-1) ... 80s Setting up zstd (1.5.7+dfsg-1) ... 80s Setting up libbpf1:ppc64el (1:1.5.0-3) ... 80s Setting up libperl5.40:ppc64el (5.40.1-3) ... 80s Setting up perl (5.40.1-3) ... 80s Processing triggers for man-db (2.13.1-1) ... 81s Processing triggers for libc-bin (2.41-6ubuntu1) ... 82s Reading package lists... 82s Building dependency tree... 82s Reading state information... 82s Starting pkgProblemResolver with broken count: 0 82s Starting 2 pkgProblemResolver with broken count: 0 82s Done 83s Solving dependencies... 83s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 85s autopkgtest [22:57:10]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 14:52:42 UTC 2025 85s autopkgtest [22:57:10]: @@@@@@@@@@@@@@@@@@@@ apt-source wyrd 86s Get:1 http://ftpmaster.internal/ubuntu questing/universe wyrd 1.7.1-2 (dsc) [1956 B] 86s Get:2 http://ftpmaster.internal/ubuntu questing/universe wyrd 1.7.1-2 (tar) [68.6 kB] 86s Get:3 http://ftpmaster.internal/ubuntu questing/universe wyrd 1.7.1-2 (diff) [5984 B] 86s gpgv: Signature made Tue Aug 6 11:20:00 2024 UTC 86s gpgv: using RSA key 6DE24E97ECA886CC56E6250E21B8EEF1B1893081 86s gpgv: issuer "glondu@debian.org" 86s gpgv: Can't check signature: No public key 86s dpkg-source: warning: cannot verify inline signature for ./wyrd_1.7.1-2.dsc: no acceptable signature found 86s autopkgtest [22:57:11]: testing package wyrd version 1.7.1-2 87s autopkgtest [22:57:12]: build not needed 87s autopkgtest [22:57:12]: test command1: preparing testbed 87s Reading package lists... 87s Building dependency tree... 87s Reading state information... 87s Starting pkgProblemResolver with broken count: 0 87s Starting 2 pkgProblemResolver with broken count: 0 87s Done 88s The following NEW packages will be installed: 88s expect libtcl8.6 remind tcl-expect tcl8.6 wyrd 88s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 88s Need to get 2650 kB of archives. 88s After this operation, 10.1 MB of additional disk space will be used. 88s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el libtcl8.6 ppc64el 8.6.16+dfsg-1 [1201 kB] 88s Get:2 http://ftpmaster.internal/ubuntu questing/main ppc64el tcl8.6 ppc64el 8.6.16+dfsg-1 [14.8 kB] 88s Get:3 http://ftpmaster.internal/ubuntu questing/universe ppc64el tcl-expect ppc64el 5.45.4-4 [122 kB] 88s Get:4 http://ftpmaster.internal/ubuntu questing/universe ppc64el expect ppc64el 5.45.4-4 [137 kB] 88s Get:5 http://ftpmaster.internal/ubuntu questing/universe ppc64el remind ppc64el 05.03.02-1 [352 kB] 88s Get:6 http://ftpmaster.internal/ubuntu questing/universe ppc64el wyrd ppc64el 1.7.1-2 [823 kB] 88s Fetched 2650 kB in 0s (6641 kB/s) 88s Selecting previously unselected package libtcl8.6:ppc64el. 88s (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 ... 78710 files and directories currently installed.) 88s Preparing to unpack .../0-libtcl8.6_8.6.16+dfsg-1_ppc64el.deb ... 88s Unpacking libtcl8.6:ppc64el (8.6.16+dfsg-1) ... 88s Selecting previously unselected package tcl8.6. 88s Preparing to unpack .../1-tcl8.6_8.6.16+dfsg-1_ppc64el.deb ... 88s Unpacking tcl8.6 (8.6.16+dfsg-1) ... 88s Selecting previously unselected package tcl-expect:ppc64el. 88s Preparing to unpack .../2-tcl-expect_5.45.4-4_ppc64el.deb ... 88s Unpacking tcl-expect:ppc64el (5.45.4-4) ... 88s Selecting previously unselected package expect. 88s Preparing to unpack .../3-expect_5.45.4-4_ppc64el.deb ... 88s Unpacking expect (5.45.4-4) ... 88s Selecting previously unselected package remind. 88s Preparing to unpack .../4-remind_05.03.02-1_ppc64el.deb ... 88s Unpacking remind (05.03.02-1) ... 88s Selecting previously unselected package wyrd. 88s Preparing to unpack .../5-wyrd_1.7.1-2_ppc64el.deb ... 88s Unpacking wyrd (1.7.1-2) ... 88s Setting up libtcl8.6:ppc64el (8.6.16+dfsg-1) ... 88s Setting up remind (05.03.02-1) ... 88s Setting up tcl8.6 (8.6.16+dfsg-1) ... 88s Setting up wyrd (1.7.1-2) ... 88s Setting up tcl-expect:ppc64el (5.45.4-4) ... 88s Setting up expect (5.45.4-4) ... 88s Processing triggers for man-db (2.13.1-1) ... 90s Processing triggers for libc-bin (2.41-6ubuntu1) ... 90s autopkgtest [22:57:15]: test command1: export HOME="$AUTOPKGTEST_TMP" && wyrd --add "drop off package at 3pm" && TERM=linux expect -c 'set stty_init "rows 60 columns 80"; spawn -nottycopy wyrd; expect_before timeout { exit 1 }; expect -re "15:00.*drop off package" { send Q; expect eof } eof; exit [lindex [wait] 3]' 90s autopkgtest [22:57:15]: test command1: [----------------------- 91s spawn -nottycopy wyrd 91s )0[?7h[?25l[?1c?:help t:new timed u:new untimed :edit :home z:zoom ... │20:00│ 0│21:00│  May 2025 4│22:00 │ Su Mo Tu We Th Fr Sa  │23:00 │1 2 3 M│00:00│ 4 5 6 7 8 9 10 a│01:00│ 11 12 13 14 15 16 17 y│02:00│ 18 19 20 21 22 23 24  │03:00│ 25 26 27 28 29 30 31 0│04:00│ 5│05:00│  │06:00├─────────────────────────────────────── │07:00│  │08:00│  │09:00│  │10:00│  │11:00│  │12:00│  │13:00│  │14:00│  │15:00 │ drop off package│  │16:00│  │17:00│  │18:00│  │19:00│  │20:00│  │21:00│  │22:00│  │23:00 │ M│00:00│ a│01:00│ y│02:00│  │03:00│ 0│04:00│ 6│05:00│  │06:00│  │07:00│  │08:00│  │09:00│  │10:00│  │11:00│  │12:00│  │13:00│  │14:00│  │15:00│  │16:00│  │17:00│  │18:00│  │19:00│  │20:00│  │21:00│  │22:00│  │23:00 │ Sunday, May 04 at 10:00pm  (no reminder selected) Wyrd v1.7.1 Currently: Sunday, May 04 at 10:57pm[?25h[?0c autopkgtest [22:57:16]: test command1: -----------------------] 91s command1 PASS 91s autopkgtest [22:57:16]: test command1: - - - - - - - - - - results - - - - - - - - - - 92s autopkgtest [22:57:17]: @@@@@@@@@@@@@@@@@@@@ summary 92s command1 PASS 106s nova [W] Using flock in prodstack7-ppc64el 106s Creating nova instance adt-questing-ppc64el-wyrd-20250504-225545-juju-7f2275-prod-proposed-migration-environment-20-2d6bcdd2-35a8-4e6e-97fd-c4194acba18f from image adt/ubuntu-questing-ppc64el-server-20250504.img (UUID 92c85200-655c-4e09-a22d-414bd7eeb396)... 106s nova [W] Timed out waiting for 383328f2-950b-40b8-bbc4-17252561c313 to get deleted.