0s autopkgtest [08:43:25]: starting date and time: 2025-06-30 08:43:25+0000 0s autopkgtest [08:43:25]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [08:43:25]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.i2jx9d1a/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:guile-fibers --apt-upgrade guile-fibers --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=guile-fibers/1.3.1-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-ppc64el-20.secgroup --name adt-questing-ppc64el-guile-fibers-20250630-082132-juju-7f2275-prod-proposed-migration-environment-2-ef20c423-1b6f-4a72-8630-94dfb8044b05 --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 2s Creating nova instance adt-questing-ppc64el-guile-fibers-20250630-082132-juju-7f2275-prod-proposed-migration-environment-2-ef20c423-1b6f-4a72-8630-94dfb8044b05 from image adt/ubuntu-questing-ppc64el-server-20250630.img (UUID 62ece32a-a77f-4f90-83a4-cbbec604149c)... 45s autopkgtest [08:44:10]: testbed dpkg architecture: ppc64el 45s autopkgtest [08:44:10]: testbed apt version: 3.1.2 45s autopkgtest [08:44:10]: @@@@@@@@@@@@@@@@@@@@ test bed setup 45s autopkgtest [08:44:10]: testbed release detected to be: None 46s autopkgtest [08:44:11]: updating testbed package index (apt update) 46s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 46s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 46s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 46s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 46s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [17.5 kB] 46s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [429 kB] 46s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [26.6 kB] 46s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [33.1 kB] 46s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [375 kB] 47s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [5260 B] 47s Fetched 1136 kB in 0s (2904 kB/s) 47s Reading package lists... 48s autopkgtest [08:44:13]: upgrading testbed (apt dist-upgrade and autopurge) 48s Reading package lists... 48s Building dependency tree... 48s Reading state information... 48s Calculating upgrade... 48s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 48s Reading package lists... 49s Building dependency tree... 49s Reading state information... 49s Solving dependencies... 49s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 51s autopkgtest [08:44:16]: testbed running kernel: Linux 6.15.0-3-generic #3-Ubuntu SMP Wed Jun 4 08:35:52 UTC 2025 51s autopkgtest [08:44:16]: @@@@@@@@@@@@@@@@@@@@ apt-source guile-fibers 52s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (dsc) [2523 B] 52s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (tar) [581 kB] 52s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (diff) [4504 B] 52s gpgv: Signature made Tue Mar 18 23:44:59 2025 UTC 52s gpgv: using EDDSA key A3CC9C870B9D310ABAD4CF2F51722B08FE4745A2 52s gpgv: issuer "simon@josefsson.org" 52s gpgv: Can't check signature: No public key 52s dpkg-source: warning: cannot verify inline signature for ./guile-fibers_1.3.1-5.dsc: no acceptable signature found 52s autopkgtest [08:44:17]: testing package guile-fibers version 1.3.1-5 53s autopkgtest [08:44:18]: build not needed 54s autopkgtest [08:44:19]: test guile-tests-basic: preparing testbed 54s Reading package lists... 54s Building dependency tree... 54s Reading state information... 54s Solving dependencies... 54s The following NEW packages will be installed: 54s guile-3.0 guile-3.0-libs guile-fibers libgc1 54s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 54s Need to get 8406 kB of archives. 54s After this operation, 60.3 MB of additional disk space will be used. 54s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el libgc1 ppc64el 1:8.2.8-1 [112 kB] 54s Get:2 http://ftpmaster.internal/ubuntu questing/universe ppc64el guile-3.0-libs ppc64el 3.0.10+really3.0.10-4 [7946 kB] 55s Get:3 http://ftpmaster.internal/ubuntu questing/universe ppc64el guile-3.0 ppc64el 3.0.10+really3.0.10-4 [16.4 kB] 55s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el guile-fibers ppc64el 1.3.1-5 [332 kB] 55s Fetched 8406 kB in 1s (16.3 MB/s) 55s Selecting previously unselected package libgc1:ppc64el. 56s (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 ... 117841 files and directories currently installed.) 56s Preparing to unpack .../libgc1_1%3a8.2.8-1_ppc64el.deb ... 56s Unpacking libgc1:ppc64el (1:8.2.8-1) ... 56s Selecting previously unselected package guile-3.0-libs:ppc64el. 56s Preparing to unpack .../guile-3.0-libs_3.0.10+really3.0.10-4_ppc64el.deb ... 56s Unpacking guile-3.0-libs:ppc64el (3.0.10+really3.0.10-4) ... 56s Selecting previously unselected package guile-3.0. 56s Preparing to unpack .../guile-3.0_3.0.10+really3.0.10-4_ppc64el.deb ... 56s Unpacking guile-3.0 (3.0.10+really3.0.10-4) ... 56s Selecting previously unselected package guile-fibers. 56s Preparing to unpack .../guile-fibers_1.3.1-5_ppc64el.deb ... 56s Unpacking guile-fibers (1.3.1-5) ... 56s Setting up libgc1:ppc64el (1:8.2.8-1) ... 56s Setting up guile-3.0-libs:ppc64el (3.0.10+really3.0.10-4) ... 56s Setting up guile-3.0 (3.0.10+really3.0.10-4) ... 56s update-alternatives: using /usr/lib/powerpc64le-linux-gnu/guile/3.0/bin/guile to provide /usr/bin/guile (guile) in auto mode 56s Setting up guile-fibers (1.3.1-5) ... 56s Processing triggers for libc-bin (2.41-6ubuntu2) ... 56s Processing triggers for man-db (2.13.1-1) ... 57s Processing triggers for install-info (7.1.1-1) ... 58s autopkgtest [08:44:23]: test guile-tests-basic: guile tests/basic.scm 58s autopkgtest [08:44:23]: test guile-tests-basic: [----------------------- 62s assert #f equal to #f: ok 62s assert #t terminates: ok 62s assert (false-if-exception (begin (run-fibers) #t)) equal to #f: ok 63s assert terminates: (run-fibers (lambda () (sleep 1)) #:drain? #t): ok (1.00409517 s) 63s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.001468611 s) 63s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.001197285 s) 63s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (7.03844e-4 s) 63s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.010109731 s) 63s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.02033617 s) 63s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.250511791 s) 63s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t))) #:drain? #t): ok (0.295514561 s) 83s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4))) #:drain? #t): ok (20.062009671 s) 94s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4 #:parallel? #t))) #:drain? #t): ok (10.142436155 s) 95s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.002722709 s) 96s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.001843814 s) 97s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.003619812 s) 98s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.009838113 s) 99s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.087733793 s) 100s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.808039641 s) 113s assert terminates: (run-fibers (lambda () (do-times 1000000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (12.468644303 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-tree 7 (lambda () (sleep 1)))) #:drain? #t): ok (1.062687101 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5)) #:drain? #t): ok (0.008857291 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50)) #:drain? #t): ok (9.72524e-4 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500)) #:drain? #t): ok (0.006163744 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000)) #:drain? #t): ok (0.047084207 s) 114s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50000)) #:drain? #t): ok (0.452593842 s) 119s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500000)) #:drain? #t): ok (4.513698379 s) 164s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000000)) #:drain? #t): ok (45.143296279 s) 164s assert terminates: (run-fibers (lambda () (test-run-order 10)) #:parallelism 1 #:drain? #t): ok (0.019546584 s) 164s assert terminates: (run-fibers (lambda () (test-wakeup-order 10)) #:parallelism 1 #:drain? #t): ok (2.91377e-4 s) 164s assert terminates: (run-fibers (lambda () 1) #:drain? #t): ok (5.51285e-4 s) 164s assert run-fiber-return-vals equal to (1): ok 165s assert terminates: (run-fibers (lambda () (do-times 20 (check-sleep (random 1.0)))) #:drain? #t): assert sleep 0.020608996598312723s < actual 0.021095324s: #t (diff: 2.359782046482998%) 165s assert sleep 0.03456686196908243s < actual 0.034683131s: #t (diff: 0.3363598090609543%) 165s assert sleep 0.061024566720115414s < actual 0.061459488s: #t (diff: 0.7126986773692623%) 165s assert sleep 0.11746097407324547s < actual 0.117653717s: #t (diff: 0.16409103387337884%) 165s assert sleep 0.13706411233780896s < actual 0.137558768s: #t (diff: 0.3608936385710533%) 165s assert sleep 0.2275100133355504s < actual 0.227778787s: #t (diff: 0.11813707032454741%) 165s assert sleep 0.23514019199674957s < actual 0.235585116s: #t (diff: 0.18921648378027658%) 165s assert sleep 0.3507339219939192s < actual 0.350870979s: #t (diff: 0.03907720282705653%) 165s assert sleep 0.36970041583284435s < actual 0.369765848s: #t (diff: 0.01769869990766766%) 165s assert sleep 0.5002849968690339s < actual 0.500360883s: #t (diff: 0.01516858019749131%) 165s assert sleep 0.6727431540500131s < actual 0.673324234s: #t (diff: 0.08637471024249296%) 165s assert sleep 0.7000185262935479s < actual 0.700146369s: #t (diff: 0.01826276043422224%) 165s assert sleep 0.7148624304124437s < actual 0.715226076s: #t (diff: 0.050869310245678694%) 165s assert sleep 0.721997240644088s < actual 0.722071869s: #t (diff: 0.010336376887730515%) 165s assert sleep 0.7233843607837082s < actual 0.723580654s: #t (diff: 0.027135396745269005%) 165s assert sleep 0.7603254888022394s < actual 0.760389367s: #t (diff: 0.00840142790179077%) 165s assert sleep 0.7965046199252751s < actual 0.796989199s: #t (diff: 0.06083820013126091%) 165s assert sleep 0.8067622687831747s < actual 0.807001406s: #t (diff: 0.029641596549380315%) 165s assert sleep 0.9299942644443119s < actual 0.930183755s: #t (diff: 0.02037545422941823%) 165s assert sleep 0.999598330708636s < actual 0.999943034s: #t (diff: 0.03448418037268704%) 165s ok (1.002088133 s) 165s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 165s ;;; or pass the --no-auto-compile argument to disable. 165s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/basic.scm 165s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 165s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/basic.scm.go 165s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 165s autopkgtest [08:46:10]: test guile-tests-basic: -----------------------] 166s guile-tests-basic PASS 166s autopkgtest [08:46:11]: test guile-tests-basic: - - - - - - - - - - results - - - - - - - - - - 166s autopkgtest [08:46:11]: test guile-tests-conditions: preparing testbed 166s Reading package lists... 166s Building dependency tree... 166s Reading state information... 166s Solving dependencies... 167s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 167s autopkgtest [08:46:12]: test guile-tests-conditions: guile tests/conditions.scm 167s autopkgtest [08:46:12]: test guile-tests-conditions: [----------------------- 169s assert (condition? cv) equal to #t: ok 169s assert run-fibers on (wait/timeout cv) terminates: ok (0.053580349 s) 169s assert run-fiber-return-vals equal to (#f): ok 169s assert run-fibers on (wait/timeout cv) terminates: ok (0.05203909 s) 169s assert run-fiber-return-vals equal to (#f): ok 169s assert (signal-condition! cv) equal to #t: ok 169s assert (signal-condition! cv) equal to #f: ok 169s assert run-fibers on (wait/timeout cv) terminates: ok (5.36346e-4 s) 169s assert run-fiber-return-vals equal to (#t): ok 169s assert run-fibers on (wait/timeout cv) terminates: ok (5.15094e-4 s) 169s assert run-fiber-return-vals equal to (#t): ok 169s assert run-fibers on (let ((cv (make-condition))) (spawn-fiber (lambda () (signal-condition! cv))) (wait cv) #t) terminates: ok (5.66172e-4 s) 169s assert run-fiber-return-vals equal to (#t): ok 169s assert (let ((cv (make-condition))) (run-fibers (lambda () (spawn-fiber (lambda () (wait cv))) (yield-current-task)) #:drain? #f #:hz 0 #:parallelism 1) (signal-condition! cv)) equal to #t: ok 169s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 169s ;;; or pass the --no-auto-compile argument to disable. 169s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/conditions.scm 169s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/conditions.scm.go 169s autopkgtest [08:46:14]: test guile-tests-conditions: -----------------------] 170s autopkgtest [08:46:15]: test guile-tests-conditions: - - - - - - - - - - results - - - - - - - - - - 170s guile-tests-conditions PASS 170s autopkgtest [08:46:15]: test guile-tests-channels: preparing testbed 170s Reading package lists... 170s Building dependency tree... 170s Reading state information... 170s Solving dependencies... 170s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 171s autopkgtest [08:46:16]: test guile-tests-channels: guile tests/channels.scm 171s autopkgtest [08:46:16]: test guile-tests-channels: [----------------------- 172s assert run-fibers on (rpc 1) terminates: ok (0.002593873 s) 172s assert run-fiber-return-vals equal to (1): ok 176s assert run-fibers on (rpc-fib 24) terminates: ok (3.799824627 s) 176s assert run-fiber-return-vals equal to (75025): ok 176s assert run-fibers on (pingpong (current-processor-count) 1000) terminates: ok (0.035832404 s) 176s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 176s ;;; or pass the --no-auto-compile argument to disable. 176s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/channels.scm 176s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/channels.scm.go 176s autopkgtest [08:46:21]: test guile-tests-channels: -----------------------] 177s guile-tests-channels PASS 177s autopkgtest [08:46:22]: test guile-tests-channels: - - - - - - - - - - results - - - - - - - - - - 177s autopkgtest [08:46:22]: test guile-tests-foreign: preparing testbed 177s Reading package lists... 177s Building dependency tree... 177s Reading state information... 177s Solving dependencies... 178s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 178s autopkgtest [08:46:23]: test guile-tests-foreign: guile tests/foreign.scm 178s autopkgtest [08:46:23]: test guile-tests-foreign: [----------------------- 179s assert #f equal to #f: ok 179s assert #t terminates: ok 180s assert (sleep 1) terminates: ok 181s assert (perform-operation (sleep-operation 1)) terminates: ok 181s assert (receive-from-fiber 42) equal to 42: ok 181s assert (send-to-fiber 42) equal to 42: ok 181s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 181s ;;; or pass the --no-auto-compile argument to disable. 181s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/foreign.scm 181s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 181s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/foreign.scm.go 181s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 181s autopkgtest [08:46:26]: test guile-tests-foreign: -----------------------] 182s guile-tests-foreign PASS 182s autopkgtest [08:46:27]: test guile-tests-foreign: - - - - - - - - - - results - - - - - - - - - - 182s autopkgtest [08:46:27]: test guile-tests-io-wakeup: preparing testbed 182s Reading package lists... 182s Building dependency tree... 182s Reading state information... 182s Solving dependencies... 182s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 183s autopkgtest [08:46:28]: test guile-tests-io-wakeup: guile tests/io-wakeup.scm 183s autopkgtest [08:46:28]: test guile-tests-io-wakeup: [----------------------- 185s assert run-fibers on (readable/timeout? s) terminates: ok (0.05213599 s) 185s assert run-fiber-return-vals equal to (#t): ok 185s assert (readable/timeout? s) equal to #t: ok 185s assert run-fibers on (readable/timeout? A) terminates: ok (0.05317545 s) 185s assert run-fiber-return-vals equal to (#t): ok 185s assert (readable/timeout? A) equal to #t: ok 185s assert run-fibers on (writable/timeout? B) terminates: ok (0.002923137 s) 185s assert run-fiber-return-vals equal to (#f): ok 185s assert (writable/timeout? B) equal to #f: ok 185s assert run-fibers on (writable/timeout? B) terminates: ok (0.053238633 s) 185s assert run-fiber-return-vals equal to (#t): ok 185s assert run-fibers on (readable/timeout? A) terminates: ok (0.010299822 s) 185s assert run-fiber-return-vals equal to (#f): ok 185s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 185s ;;; or pass the --no-auto-compile argument to disable. 185s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/io-wakeup.scm 185s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/io-wakeup.scm.go 186s autopkgtest [08:46:31]: test guile-tests-io-wakeup: -----------------------] 186s autopkgtest [08:46:31]: test guile-tests-io-wakeup: - - - - - - - - - - results - - - - - - - - - - 186s guile-tests-io-wakeup PASS 186s autopkgtest [08:46:31]: test guile-tests-parameters: preparing testbed 186s Reading package lists... 187s Building dependency tree... 187s Reading state information... 187s Solving dependencies... 187s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 187s autopkgtest [08:46:32]: test guile-tests-parameters: guile tests/parameters.scm 187s autopkgtest [08:46:32]: test guile-tests-parameters: [----------------------- 10187s assert run-fibers on (my-param) terminates: autopkgtest [11:33:12]: ERROR: timed out on command "su -s /bin/bash ubuntu -c set -e; exec /tmp/autopkgtest.8EfG94/wrapper.sh --artifacts=/tmp/autopkgtest.8EfG94/guile-tests-parameters-artifacts --chdir=/tmp/autopkgtest.8EfG94/build.06Q/src --env=AUTOPKGTEST_TESTBED_ARCH=ppc64el --env=AUTOPKGTEST_TEST_ARCH=ppc64el --env=DEB_BUILD_OPTIONS=parallel=2 --env=DEBIAN_FRONTEND=noninteractive --env=LANG=C.UTF-8 --unset-env=LANGUAGE --unset-env=LC_ADDRESS --unset-env=LC_ALL --unset-env=LC_COLLATE --unset-env=LC_CTYPE --unset-env=LC_IDENTIFICATION --unset-env=LC_MEASUREMENT --unset-env=LC_MESSAGES --unset-env=LC_MONETARY --unset-env=LC_NAME --unset-env=LC_NUMERIC --unset-env=LC_PAPER --unset-env=LC_TELEPHONE --unset-env=LC_TIME --script-pid-file=/tmp/autopkgtest_script_pid --source-profile --stderr=/tmp/autopkgtest.8EfG94/guile-tests-parameters-stderr --stdout=/tmp/autopkgtest.8EfG94/guile-tests-parameters-stdout --tmp=/tmp/autopkgtest.8EfG94/autopkgtest_tmp --env=ADT_TEST_TRIGGERS=guile-fibers/1.3.1-5 -- bash -ec 'guile tests/parameters.scm'" (kind: test) 10188s autopkgtest [11:33:13]: test guile-tests-parameters: -----------------------] 10188s autopkgtest [11:33:13]: test guile-tests-parameters: - - - - - - - - - - results - - - - - - - - - - 10188s guile-tests-parameters FAIL timed out 10188s autopkgtest [11:33:13]: test guile-tests-preemption: preparing testbed 10189s Reading package lists... 10189s Building dependency tree... 10189s Reading state information... 10189s Solving dependencies... 10189s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 10189s autopkgtest [11:33:14]: test guile-tests-preemption: guile tests/preemption.scm 10189s autopkgtest [11:33:14]: test guile-tests-preemption: [----------------------- 10193s assert run-fibers on (let lp ((n 0)) (when (< n 100000000) (lp (#{1+}# n)))) terminates: ok (2.284144626 s) 10194s assert run-fibers on (race-until 100) terminates: ok (1.194370879 s) 10194s assert run-fiber-return-vals equal to (100): ok 10194s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 10194s ;;; or pass the --no-auto-compile argument to disable. 10194s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/preemption.scm 10194s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/preemption.scm.go 10194s autopkgtest [11:33:19]: test guile-tests-preemption: -----------------------] 10195s autopkgtest [11:33:20]: test guile-tests-preemption: - - - - - - - - - - results - - - - - - - - - - 10195s guile-tests-preemption PASS 10195s autopkgtest [11:33:20]: test guile-tests-speedup: preparing testbed 10195s Reading package lists... 10195s Building dependency tree... 10195s Reading state information... 10195s Solving dependencies... 10195s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 10196s autopkgtest [11:33:21]: test guile-tests-speedup: guile tests/speedup.scm 10196s autopkgtest [11:33:21]: test guile-tests-speedup: [----------------------- 10198s speedup for (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t)): 0.260195949 s / 0.29509656 s = 0.8817315559354537x (2 cpus) 10201s speedup for (do-times 40000 (spawn-fiber (lambda () (sleep 1)) #:parallel? #t)): 1.334349711 s / 1.210963533 s = 1.1018909113590956x (2 cpus) 10235s speedup for (do-times 100000 (spawn-fiber (lambda () (loop-to 10000)) #:parallel? #t)): 22.957095281 s / 11.568538405 s = 1.984442154860098x (2 cpus) 10269s speedup for (do-times 10000 (spawn-fiber (lambda () (loop-to 100000)) #:parallel? #t)): 22.698146473 s / 11.36435409 s = 1.9973107396374694x (2 cpus) 10303s speedup for (do-times 1000 (spawn-fiber (lambda () (loop-to 1000000)) #:parallel? #t)): 22.664123826 s / 11.334792853 s = 1.9995181314673471x (2 cpus) 10320s speedup for (do-times 100000 (spawn-fiber (lambda () (alloc-to 4 1000)) #:parallel? #t)): 10.703588752 s / 6.130736853 s = 1.7458894434136953x (2 cpus) 10336s speedup for (do-times 10000 (spawn-fiber (lambda () (alloc-to 4 10000)) #:parallel? #t)): 10.320781197 s / 5.891215961 s = 1.7518932025788623x (2 cpus) 10352s speedup for (do-times 1000 (spawn-fiber (lambda () (alloc-to 4 100000)) #:parallel? #t)): 10.28622499 s / 5.710715957 s = 1.8012146055682383x (2 cpus) 10352s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 10352s ;;; or pass the --no-auto-compile argument to disable. 10352s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/speedup.scm 10352s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 10352s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/speedup.scm.go 10352s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 10353s autopkgtest [11:35:58]: test guile-tests-speedup: -----------------------] 10353s guile-tests-speedup PASS 10353s autopkgtest [11:35:58]: test guile-tests-speedup: - - - - - - - - - - results - - - - - - - - - - 10353s autopkgtest [11:35:58]: test guile-tests-timer-wheel: preparing testbed 10353s Reading package lists... 10353s Building dependency tree... 10353s Reading state information... 10353s Solving dependencies... 10354s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 10354s autopkgtest [11:35:59]: test guile-tests-timer-wheel: guile tests/timer-wheel.scm 10354s autopkgtest [11:35:59]: test guile-tests-timer-wheel: [----------------------- 10357s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 10357s ;;; or pass the --no-auto-compile argument to disable. 10357s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/timer-wheel.scm 10357s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/timer-wheel.scm.go 10358s autopkgtest [11:36:03]: test guile-tests-timer-wheel: -----------------------] 10358s guile-tests-timer-wheel PASS 10358s autopkgtest [11:36:03]: test guile-tests-timer-wheel: - - - - - - - - - - results - - - - - - - - - - 10358s autopkgtest [11:36:03]: test guile-tests-ports: preparing testbed 10358s Reading package lists... 10359s Building dependency tree... 10359s Reading state information... 10359s Solving dependencies... 10359s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 10359s autopkgtest [11:36:04]: test guile-tests-ports: guile tests/ports.scm 10359s autopkgtest [11:36:04]: test guile-tests-ports: [----------------------- 10365s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 10365s ;;; or pass the --no-auto-compile argument to disable. 10365s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/ports.scm 10365s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 10365s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/ports.scm.go 10365s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 10365s success 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (listening-socket #) 10365s 10365s ;;; (accepted-connection (# . #(2 2130706433 52150))) 10365s 10365s ;;; (connected #(2 2130706433 5556)) 10365s 10365s ;;; (received "hello!") 10365s 10365s ;;; (echo "hello!") 10366s autopkgtest [11:36:11]: test guile-tests-ports: -----------------------] 10366s guile-tests-ports PASS 10366s autopkgtest [11:36:11]: test guile-tests-ports: - - - - - - - - - - results - - - - - - - - - - 10366s autopkgtest [11:36:11]: test guile-tests-concurrent-web-server: preparing testbed 10367s Reading package lists... 10367s Building dependency tree... 10367s Reading state information... 10367s Solving dependencies... 10367s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 10368s autopkgtest [11:36:13]: test guile-tests-concurrent-web-server: guile tests/concurrent-web-server.scm 10368s autopkgtest [11:36:13]: test guile-tests-concurrent-web-server: [----------------------- 10373s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 10373s ;;; or pass the --no-auto-compile argument to disable. 10373s ;;; compiling /tmp/autopkgtest.8EfG94/build.06Q/src/tests/concurrent-web-server.scm 10373s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.8EfG94/build.06Q/src/tests/concurrent-web-server.scm.go 10373s Backtrace: 10373s In ice-9/boot-9.scm: 10373s 1755:12 7 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _) 10373s In unknown file: 10373s 6 (apply-smob/0 #) 10373s In ice-9/boot-9.scm: 10373s 724:2 5 (call-with-prompt _ _ #) 10373s In ice-9/eval.scm: 10373s 619:8 4 (_ #(#(#))) 10373s In ice-9/boot-9.scm: 10373s 2858:4 3 (save-module-excursion _) 10373s 4408:12 2 (_) 10373s In /tmp/autopkgtest.8EfG94/build.06Q/src/tests/concurrent-web-server.scm: 10373s 83:11 1 (_) 10373s In unknown file: 10373s 0 (bytevector->uint-list #vu8(60 33 68 79 67 84 89 80 69 32 104 116 109 108 32 80 85 66 76 73 67 32 34 45 47 47 87 51 67 47 47 68 84 68 32 72 84 77 76 32 52 46 48 49 47 47 69 78 34 32 34 104 116 116 112 58 47 47 119 119 119 46 119 51 46 111 114 103 47 84 82 47 104 116 109 108 52 47 115 116 114 105 99 116 46 100 116 100 34 62 10 60 104 116 109 108 62 60 104 101 97 100 62 10 60 109 101 116 97 32 116 121 112 101 61 34 99 111 112 121 114 105 103 104 116 34 32 99 111 110 116 101 110 …) …) 10373s 10373s ERROR: In procedure bytevector->uint-list: 10373s In procedure bytevector->uint-list: Wrong type (expecting an exact positive integer that divides the bytevector length): 4 10374s autopkgtest [11:36:19]: test guile-tests-concurrent-web-server: -----------------------] 10374s autopkgtest [11:36:19]: test guile-tests-concurrent-web-server: - - - - - - - - - - results - - - - - - - - - - 10374s guile-tests-concurrent-web-server FAIL non-zero exit status 1 10374s autopkgtest [11:36:19]: @@@@@@@@@@@@@@@@@@@@ summary 10374s guile-tests-basic PASS 10374s guile-tests-conditions PASS 10374s guile-tests-channels PASS 10374s guile-tests-foreign PASS 10374s guile-tests-io-wakeup PASS 10374s guile-tests-parameters FAIL timed out 10374s guile-tests-preemption PASS 10374s guile-tests-speedup PASS 10374s guile-tests-timer-wheel PASS 10374s guile-tests-ports PASS 10374s guile-tests-concurrent-web-server FAIL non-zero exit status 1