0s autopkgtest [11:52:49]: starting date and time: 2025-05-06 11:52:49+0000 0s autopkgtest [11:52:49]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [11:52:49]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.dvyfl24c/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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-s390x-10.secgroup --name adt-questing-s390x-guile-fibers-20250506-115249-juju-7f2275-prod-proposed-migration-environment-15-76a3dcd9-7e2e-4c1f-9dcf-3b4b68c6cd9a --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 252s autopkgtest [11:57:01]: testbed dpkg architecture: s390x 253s autopkgtest [11:57:01]: testbed apt version: 3.0.0 253s autopkgtest [11:57:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 253s autopkgtest [11:57:02]: testbed release detected to be: None 254s autopkgtest [11:57:03]: updating testbed package index (apt update) 255s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 255s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 255s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 255s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 255s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [72.4 kB] 256s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [595 kB] 256s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [27.3 kB] 256s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [136 kB] 256s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [612 kB] 256s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.0 kB] 257s Fetched 1567 kB in 2s (745 kB/s) 262s Reading package lists... 263s autopkgtest [11:57:12]: upgrading testbed (apt dist-upgrade and autopurge) 264s Reading package lists... 265s Building dependency tree... 265s Reading state information... 267s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 267s Starting 2 pkgProblemResolver with broken count: 0 267s Done 269s Entering ResolveByKeep 270s 271s Calculating upgrade... 272s The following packages will be upgraded: 272s libperl5.40 perl perl-base perl-modules-5.40 python3-dbus 272s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 272s Need to get 10.5 MB of archives. 272s After this operation, 3072 B of additional disk space will be used. 272s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libperl5.40 s390x 5.40.1-3 [4972 kB] 272s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x perl s390x 5.40.1-3 [262 kB] 272s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x perl-base s390x 5.40.1-3 [1954 kB] 272s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x perl-modules-5.40 all 5.40.1-3 [3217 kB] 272s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x python3-dbus s390x 1.4.0-1 [102 kB] 273s Fetched 10.5 MB in 1s (15.4 MB/s) 273s (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 ... 59837 files and directories currently installed.) 273s Preparing to unpack .../libperl5.40_5.40.1-3_s390x.deb ... 273s Unpacking libperl5.40:s390x (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 274s Preparing to unpack .../perl_5.40.1-3_s390x.deb ... 274s Unpacking perl (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 274s Preparing to unpack .../perl-base_5.40.1-3_s390x.deb ... 274s Unpacking perl-base (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 275s Setting up perl-base (5.40.1-3) ... 275s (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 ... 59837 files and directories currently installed.) 275s Preparing to unpack .../perl-modules-5.40_5.40.1-3_all.deb ... 275s Unpacking perl-modules-5.40 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 276s Preparing to unpack .../python3-dbus_1.4.0-1_s390x.deb ... 276s Unpacking python3-dbus (1.4.0-1) over (1.3.2-5build5) ... 276s Setting up python3-dbus (1.4.0-1) ... 276s Setting up perl-modules-5.40 (5.40.1-3) ... 276s Setting up libperl5.40:s390x (5.40.1-3) ... 276s Setting up perl (5.40.1-3) ... 276s Processing triggers for man-db (2.13.1-1) ... 278s Processing triggers for libc-bin (2.41-6ubuntu1) ... 279s Reading package lists... 279s Building dependency tree... 279s Reading state information... 279s Starting pkgProblemResolver with broken count: 0 279s Starting 2 pkgProblemResolver with broken count: 0 279s Done 280s Solving dependencies... 281s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 283s autopkgtest [11:57:32]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 13:39:00 UTC 2025 283s autopkgtest [11:57:32]: @@@@@@@@@@@@@@@@@@@@ apt-source guile-fibers 285s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (dsc) [2523 B] 285s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (tar) [581 kB] 285s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/universe guile-fibers 1.3.1-5 (diff) [4504 B] 285s gpgv: Signature made Tue Mar 18 23:44:59 2025 UTC 285s gpgv: using EDDSA key A3CC9C870B9D310ABAD4CF2F51722B08FE4745A2 285s gpgv: issuer "simon@josefsson.org" 285s gpgv: Can't check signature: No public key 285s dpkg-source: warning: cannot verify inline signature for ./guile-fibers_1.3.1-5.dsc: no acceptable signature found 285s autopkgtest [11:57:34]: testing package guile-fibers version 1.3.1-5 286s autopkgtest [11:57:35]: build not needed 286s autopkgtest [11:57:35]: test guile-tests-basic: preparing testbed 287s Reading package lists... 287s Building dependency tree... 287s Reading state information... 287s Starting pkgProblemResolver with broken count: 0 287s Starting 2 pkgProblemResolver with broken count: 0 287s Done 287s The following NEW packages will be installed: 287s guile-3.0 guile-3.0-libs guile-fibers libgc1 287s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 287s Need to get 8332 kB of archives. 287s After this operation, 59.6 MB of additional disk space will be used. 287s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libgc1 s390x 1:8.2.8-1 [93.7 kB] 287s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x guile-3.0-libs s390x 3.0.10+really3.0.10-4 [7889 kB] 288s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x guile-3.0 s390x 3.0.10+really3.0.10-4 [16.4 kB] 288s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x guile-fibers s390x 1.3.1-5 [332 kB] 288s Fetched 8332 kB in 0s (16.9 MB/s) 288s Selecting previously unselected package libgc1:s390x. 288s (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 ... 59837 files and directories currently installed.) 288s Preparing to unpack .../libgc1_1%3a8.2.8-1_s390x.deb ... 288s Unpacking libgc1:s390x (1:8.2.8-1) ... 288s Selecting previously unselected package guile-3.0-libs:s390x. 288s Preparing to unpack .../guile-3.0-libs_3.0.10+really3.0.10-4_s390x.deb ... 288s Unpacking guile-3.0-libs:s390x (3.0.10+really3.0.10-4) ... 288s Selecting previously unselected package guile-3.0. 288s Preparing to unpack .../guile-3.0_3.0.10+really3.0.10-4_s390x.deb ... 288s Unpacking guile-3.0 (3.0.10+really3.0.10-4) ... 288s Selecting previously unselected package guile-fibers. 288s Preparing to unpack .../guile-fibers_1.3.1-5_s390x.deb ... 288s Unpacking guile-fibers (1.3.1-5) ... 288s Setting up libgc1:s390x (1:8.2.8-1) ... 288s Setting up guile-3.0-libs:s390x (3.0.10+really3.0.10-4) ... 288s Setting up guile-3.0 (3.0.10+really3.0.10-4) ... 288s update-alternatives: using /usr/lib/s390x-linux-gnu/guile/3.0/bin/guile to provide /usr/bin/guile (guile) in auto mode 288s Setting up guile-fibers (1.3.1-5) ... 288s Processing triggers for libc-bin (2.41-6ubuntu1) ... 288s Processing triggers for man-db (2.13.1-1) ... 289s Processing triggers for install-info (7.1.1-1) ... 290s autopkgtest [11:57:39]: test guile-tests-basic: guile tests/basic.scm 290s autopkgtest [11:57:39]: test guile-tests-basic: [----------------------- 296s assert #f equal to #f: ok 296s assert #t terminates: ok 296s assert (false-if-exception (begin (run-fibers) #t)) equal to #f: ok 297s assert terminates: (run-fibers (lambda () (sleep 1)) #:drain? #t): ok (1.00825361 s) 297s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (5.32561e-4 s) 297s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (4.41271e-4 s) 297s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (4.90798e-4 s) 297s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.001635253 s) 297s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.011361882 s) 297s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.209760903 s) 298s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t))) #:drain? #t): ok (0.575847209 s) 320s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4))) #:drain? #t): ok (22.514918522 s) 327s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4 #:parallel? #t))) #:drain? #t): ok (7.316785187 s) 328s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.01012267 s) 329s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.001246753 s) 330s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.011983104 s) 331s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.005609195 s) 333s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.118515504 s) 336s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (3.373860375 s) 353s assert terminates: (run-fibers (lambda () (do-times 1000000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (16.708327601 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-tree 7 (lambda () (sleep 1)))) #:drain? #t): ok (1.027513416 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5)) #:drain? #t): ok (4.29915e-4 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50)) #:drain? #t): ok (5.35547e-4 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500)) #:drain? #t): ok (0.002042767 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000)) #:drain? #t): ok (0.017070126 s) 354s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50000)) #:drain? #t): ok (0.431883874 s) 359s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500000)) #:drain? #t): ok (4.734495592 s) 395s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000000)) #:drain? #t): ok (35.681792748 s) 395s assert terminates: (run-fibers (lambda () (test-run-order 10)) #:parallelism 1 #:drain? #t): ok (0.017675281 s) 395s assert terminates: (run-fibers (lambda () (test-wakeup-order 10)) #:parallelism 1 #:drain? #t): ok (9.78463e-4 s) 395s assert terminates: (run-fibers (lambda () 1) #:drain? #t): ok (3.08008e-4 s) 395s assert run-fiber-return-vals equal to (1): ok 396s assert terminates: (run-fibers (lambda () (do-times 20 (check-sleep (random 1.0)))) #:drain? #t): assert sleep 0.020608996598312723s < actual 0.020739917s: #t (diff: 0.6352584953019761%) 396s assert sleep 0.03456686196908243s < actual 0.034877688s: #t (diff: 0.8992023377637773%) 396s assert sleep 0.061024566720115414s < actual 0.061106429s: #t (diff: 0.1341464336158878%) 396s assert sleep 0.11746097407324547s < actual 0.117760644s: #t (diff: 0.25512297094323155%) 396s assert sleep 0.13706411233780896s < actual 0.13717142s: #t (diff: 0.07829012303859241%) 396s assert sleep 0.2275100133355504s < actual 0.227895164s: #t (diff: 0.16928954414043984%) 396s assert sleep 0.23514019199674957s < actual 0.2352024s: #t (diff: 0.026455708282867973%) 396s assert sleep 0.3507339219939192s < actual 0.351040991s: #t (diff: 0.0875504155215916%) 396s assert sleep 0.36970041583284435s < actual 0.369925408s: #t (diff: 0.06085796972903194%) 396s assert sleep 0.5002849968690339s < actual 0.500498296s: #t (diff: 0.04263552421138346%) 396s assert sleep 0.6727431540500131s < actual 0.672966107s: #t (diff: 0.03314087235890351%) 396s assert sleep 0.7000185262935479s < actual 0.700249976s: #t (diff: 0.0330633687193462%) 396s assert sleep 0.7148624304124437s < actual 0.71488476s: #t (diff: 0.0031236202388536982%) 396s assert sleep 0.721997240644088s < actual 0.722236615s: #t (diff: 0.03315446963460588%) 396s assert sleep 0.7233843607837082s < actual 0.723795619s: #t (diff: 0.05685196398858965%) 396s assert sleep 0.7603254888022394s < actual 0.760519381s: #t (diff: 0.025501209760324287%) 396s assert sleep 0.7965046199252751s < actual 0.796664189s: #t (diff: 0.020033665936537708%) 396s assert sleep 0.8067622687831747s < actual 0.807174806s: #t (diff: 0.05113491703665674%) 396s assert sleep 0.9299942644443119s < actual 0.930405322s: #t (diff: 0.04420000976390632%) 396s assert sleep 0.999598330708636s < actual 1.000123399s: #t (diff: 0.05252792799201396%) 396s ok (1.000705381 s) 396s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 396s ;;; or pass the --no-auto-compile argument to disable. 396s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/basic.scm 396s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 396s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/basic.scm.go 396s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 396s autopkgtest [11:59:25]: test guile-tests-basic: -----------------------] 396s guile-tests-basic PASS 396s autopkgtest [11:59:25]: test guile-tests-basic: - - - - - - - - - - results - - - - - - - - - - 396s autopkgtest [11:59:25]: test guile-tests-conditions: preparing testbed 397s Reading package lists... 397s Building dependency tree... 397s Reading state information... 397s Starting pkgProblemResolver with broken count: 0 397s Starting 2 pkgProblemResolver with broken count: 0 397s Done 397s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 398s autopkgtest [11:59:27]: test guile-tests-conditions: guile tests/conditions.scm 398s autopkgtest [11:59:27]: test guile-tests-conditions: [----------------------- 399s assert (condition? cv) equal to #t: ok 399s assert run-fibers on (wait/timeout cv) terminates: ok (0.050710741 s) 399s assert run-fiber-return-vals equal to (#f): ok 399s assert run-fibers on (wait/timeout cv) terminates: ok (0.050707351 s) 399s assert run-fiber-return-vals equal to (#f): ok 399s assert (signal-condition! cv) equal to #t: ok 399s assert (signal-condition! cv) equal to #f: ok 399s assert run-fibers on (wait/timeout cv) terminates: ok (3.92741e-4 s) 399s assert run-fiber-return-vals equal to (#t): ok 399s assert run-fibers on (wait/timeout cv) terminates: ok (2.81392e-4 s) 399s assert run-fiber-return-vals equal to (#t): ok 399s assert run-fibers on (let ((cv (make-condition))) (spawn-fiber (lambda () (signal-condition! cv))) (wait cv) #t) terminates: ok (3.27867e-4 s) 399s assert run-fiber-return-vals equal to (#t): ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 399s ;;; or pass the --no-auto-compile argument to disable. 399s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/conditions.scm 399s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/conditions.scm.go 399s ok 399s 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 399s autopkgtest [11:59:28]: test guile-tests-conditions: -----------------------] 399s guile-tests-conditions PASS 399s autopkgtest [11:59:28]: test guile-tests-conditions: - - - - - - - - - - results - - - - - - - - - - 400s autopkgtest [11:59:29]: test guile-tests-channels: preparing testbed 400s Reading package lists... 400s Building dependency tree... 400s Reading state information... 400s Starting pkgProblemResolver with broken count: 0 400s Starting 2 pkgProblemResolver with broken count: 0 400s Done 401s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 402s autopkgtest [11:59:31]: test guile-tests-channels: guile tests/channels.scm 402s autopkgtest [11:59:31]: test guile-tests-channels: [----------------------- 403s assert run-fibers on (rpc 1) terminates: ok (0.00109586 s) 403s assert run-fiber-return-vals equal to (1): ok 405s assert run-fibers on (rpc-fib 24) terminates: ok (2.059614978 s) 405s assert run-fiber-return-vals equal to (75025): ok 405s assert run-fibers on (pingpong (current-processor-count) 1000) terminates: ok (0.011687776 s) 405s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 405s ;;; or pass the --no-auto-compile argument to disable. 405s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/channels.scm 405s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/channels.scm.go 406s autopkgtest [11:59:35]: test guile-tests-channels: -----------------------] 406s guile-tests-channels PASS 406s autopkgtest [11:59:35]: test guile-tests-channels: - - - - - - - - - - results - - - - - - - - - - 406s autopkgtest [11:59:35]: test guile-tests-foreign: preparing testbed 406s Reading package lists... 407s Building dependency tree... 407s Reading state information... 407s Starting pkgProblemResolver with broken count: 0 407s Starting 2 pkgProblemResolver with broken count: 0 407s Done 407s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 408s autopkgtest [11:59:37]: test guile-tests-foreign: guile tests/foreign.scm 408s autopkgtest [11:59:37]: test guile-tests-foreign: [----------------------- 408s assert #f equal to #f: ok 408s assert #t terminates: ok 409s assert (sleep 1) terminates: ok 410s assert (perform-operation (sleep-operation 1)) terminates: ok 410s assert (receive-from-fiber 42) equal to 42: ok 410s assert (send-to-fiber 42) equal to 42: ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 410s ;;; or pass the --no-auto-compile argument to disable. 410s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/foreign.scm 410s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 410s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/foreign.scm.go 410s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 410s ok 410s autopkgtest [11:59:39]: test guile-tests-foreign: -----------------------] 411s guile-tests-foreign PASS 411s autopkgtest [11:59:40]: test guile-tests-foreign: - - - - - - - - - - results - - - - - - - - - - 411s autopkgtest [11:59:40]: test guile-tests-io-wakeup: preparing testbed 411s Reading package lists... 411s Building dependency tree... 411s Reading state information... 411s Starting pkgProblemResolver with broken count: 0 411s Starting 2 pkgProblemResolver with broken count: 0 411s Done 412s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 414s autopkgtest [11:59:43]: test guile-tests-io-wakeup: guile tests/io-wakeup.scm 414s autopkgtest [11:59:43]: test guile-tests-io-wakeup: [----------------------- 419s assert run-fibers on (readable/timeout? s) terminates: ok (0.051846419 s) 419s assert run-fiber-return-vals equal to (#t): ok 419s assert (readable/timeout? s) equal to #t: ok 419s assert run-fibers on (readable/timeout? A) terminates: ok (0.050663426 s) 419s assert run-fiber-return-vals equal to (#t): ok 419s assert (readable/timeout? A) equal to #t: ok 419s assert run-fibers on (writable/timeout? B) terminates: ok (9.04601e-4 s) 419s assert run-fiber-return-vals equal to (#f): ok 419s assert (writable/timeout? B) equal to #f: ok 419s assert run-fibers on (writable/timeout? B) terminates: ok (0.050506341 s) 419s assert run-fiber-return-vals equal to (#t): ok 419s assert run-fibers on (readable/timeout? A) terminates: ok (4.28542e-4 s) 419s assert run-fiber-return-vals equal to (#f): ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 419s ;;; or pass the --no-auto-compile argument to disable. 419s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/io-wakeup.scm 419s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/io-wakeup.scm.go 419s ok 419s autopkgtest [11:59:48]: test guile-tests-io-wakeup: -----------------------] 420s guile-tests-io-wakeup PASS 420s autopkgtest [11:59:49]: test guile-tests-io-wakeup: - - - - - - - - - - results - - - - - - - - - - 420s autopkgtest [11:59:49]: test guile-tests-parameters: preparing testbed 420s Reading package lists... 420s Building dependency tree... 420s Reading state information... 421s Starting pkgProblemResolver with broken count: 0 421s Starting 2 pkgProblemResolver with broken count: 0 421s Done 421s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 421s autopkgtest [11:59:50]: test guile-tests-parameters: guile tests/parameters.scm 421s autopkgtest [11:59:50]: test guile-tests-parameters: [----------------------- 423s assert run-fibers on (my-param) terminates: ok (7.06169e-4 s) 424s assert run-fiber-return-vals equal to (#f): ok 424s assert run-fibers on (rpc (my-param)) terminates: ok (3.44631e-4 s) 424s assert run-fiber-return-vals equal to (#f): ok 424s assert run-fibers on (rpc (begin (my-param 42) (my-param))) terminates: ok (2.77666e-4 s) 424s assert run-fiber-return-vals equal to (42): ok 424s assert run-fibers on (my-param) terminates: ok (2.07327e-4 s) 424s assert run-fiber-return-vals equal to (#f): ok 424s assert run-fibers on (begin (my-param 100) (rpc (my-param))) terminates: ok (3.1611e-4 s) 424s assert run-fiber-return-vals equal to (100): ok 424s assert run-fibers on (my-param) terminates: ok (2.68215e-4 s) 424s assert run-fiber-return-vals equal to (#f): ok 424s assert (my-param) equal to #f: ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 424s ;;; or pass the --no-auto-compile argument to disable. 424s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/parameters.scm 424s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/parameters.scm.go 424s ok 424s assert (begin (my-param (quote foo)) (my-param)) equal to foo: ok 424s assert run-fibers on (my-param) terminates: ok (2.55436e-4 s) 424s assert run-fiber-return-vals equal to (foo): ok 424s assert run-fibers on (rpc (my-param)) terminates: ok (2.61448e-4 s) 424s assert run-fiber-return-vals equal to (foo): ok 424s autopkgtest [11:59:52]: test guile-tests-parameters: -----------------------] 424s autopkgtest [11:59:53]: test guile-tests-parameters: - - - - - - - - - - results - - - - - - - - - - 424s guile-tests-parameters PASS 424s autopkgtest [11:59:53]: test guile-tests-preemption: preparing testbed 425s Reading package lists... 425s Building dependency tree... 425s Reading state information... 425s Starting pkgProblemResolver with broken count: 0 425s Starting 2 pkgProblemResolver with broken count: 0 425s Done 425s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 426s autopkgtest [11:59:55]: test guile-tests-preemption: guile tests/preemption.scm 426s autopkgtest [11:59:55]: test guile-tests-preemption: [----------------------- 427s assert run-fibers on (let lp ((n 0)) (when (< n 100000000) (lp (#{1+}# n)))) terminates: ok (0.530282731 s) 430s assert run-fibers on (race-until 100) terminates: ok (3.336655144 s) 430s assert run-fiber-return-vals equal to (100): ok 430s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 430s ;;; or pass the --no-auto-compile argument to disable. 430s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/preemption.scm 430s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/preemption.scm.go 430s autopkgtest [11:59:59]: test guile-tests-preemption: -----------------------] 431s autopkgtest [12:00:00]: test guile-tests-preemption: - - - - - - - - - - results - - - - - - - - - - 431s guile-tests-preemption PASS 431s autopkgtest [12:00:00]: test guile-tests-speedup: preparing testbed 431s Reading package lists... 431s Building dependency tree... 431s Reading state information... 431s Starting pkgProblemResolver with broken count: 0 432s Starting 2 pkgProblemResolver with broken count: 0 432s Done 432s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 432s autopkgtest [12:00:01]: test guile-tests-speedup: guile tests/speedup.scm 432s autopkgtest [12:00:01]: test guile-tests-speedup: [----------------------- 434s speedup for (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t)): 0.207333359 s / 0.149107902 s = 1.3904920947784511x (2 cpus) 436s speedup for (do-times 40000 (spawn-fiber (lambda () (sleep 1)) #:parallel? #t)): 1.148557555 s / 1.159090976 s = 0.990912343191256x (2 cpus) 454s speedup for (do-times 100000 (spawn-fiber (lambda () (loop-to 10000)) #:parallel? #t)): 11.396691119 s / 5.941047272 s = 1.9182966566706694x (2 cpus) 482s speedup for (do-times 10000 (spawn-fiber (lambda () (loop-to 100000)) #:parallel? #t)): 20.915465773 s / 7.103047809 s = 2.9445762347958313x (2 cpus) 518s speedup for (do-times 1000 (spawn-fiber (lambda () (loop-to 1000000)) #:parallel? #t)): 26.448604945 s / 9.994897779 s = 2.646210649654709x (2 cpus) 533s speedup for (do-times 100000 (spawn-fiber (lambda () (alloc-to 4 1000)) #:parallel? #t)): 10.317150135 s / 4.01790929 s = 2.5677907066438523x (2 cpus) 553s speedup for (do-times 10000 (spawn-fiber (lambda () (alloc-to 4 10000)) #:parallel? #t)): 16.678787809 s / 3.842869928 s = 4.340190566293869x (2 cpus) 564s speedup for (do-times 1000 (spawn-fiber (lambda () (alloc-to 4 100000)) #:parallel? #t)): 6.918566762 s / 4.423468875 s = 1.564059103275594x (2 cpus) 564s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 564s ;;; or pass the --no-auto-compile argument to disable. 564s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/speedup.scm 564s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 564s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/speedup.scm.go 564s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 565s autopkgtest [12:02:14]: test guile-tests-speedup: -----------------------] 565s guile-tests-speedup PASS 565s autopkgtest [12:02:14]: test guile-tests-speedup: - - - - - - - - - - results - - - - - - - - - - 565s autopkgtest [12:02:14]: test guile-tests-timer-wheel: preparing testbed 566s Reading package lists... 566s Building dependency tree... 566s Reading state information... 566s Starting pkgProblemResolver with broken count: 0 566s Starting 2 pkgProblemResolver with broken count: 0 566s Done 566s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 567s autopkgtest [12:02:16]: test guile-tests-timer-wheel: guile tests/timer-wheel.scm 567s autopkgtest [12:02:16]: test guile-tests-timer-wheel: [----------------------- 570s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 570s ;;; or pass the --no-auto-compile argument to disable. 570s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/timer-wheel.scm 570s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/timer-wheel.scm.go 570s autopkgtest [12:02:19]: test guile-tests-timer-wheel: -----------------------] 570s autopkgtest [12:02:19]: test guile-tests-timer-wheel: - - - - - - - - - - results - - - - - - - - - - 570s guile-tests-timer-wheel PASS 571s autopkgtest [12:02:20]: test guile-tests-ports: preparing testbed 571s Reading package lists... 571s Building dependency tree... 571s Reading state information... 571s Starting pkgProblemResolver with broken count: 0 571s Starting 2 pkgProblemResolver with broken count: 0 571s Done 571s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 572s autopkgtest [12:02:21]: test guile-tests-ports: guile tests/ports.scm 572s autopkgtest [12:02:21]: test guile-tests-ports: [----------------------- 578s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 578s ;;; or pass the --no-auto-compile argument to disable. 578s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/ports.scm 578s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 578s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/ports.scm.go 578s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 578s success 578s 578s ;;; (listening-socket #) 578s 578s ;;; (listening-socket #) 578s 578s ;;; (listening-socket #) 578s 578s ;;; (listening-socket #) 578s 578s ;;; (listening-socket #) 578s 578s ;;; (listening-socket #) 578s 578s ;;; (accepted-connection (# . #(2 2130706433 58538))) 578s 578s ;;; (connected #(2 2130706433 5556)) 578s 578s ;;; (received "hello!") 578s 578s ;;; (echo "hello!") 578s autopkgtest [12:02:27]: test guile-tests-ports: -----------------------] 579s autopkgtest [12:02:28]: test guile-tests-ports: - - - - - - - - - - results - - - - - - - - - - 579s guile-tests-ports PASS 579s autopkgtest [12:02:28]: test guile-tests-concurrent-web-server: preparing testbed 579s Reading package lists... 580s Building dependency tree... 580s Reading state information... 580s Starting pkgProblemResolver with broken count: 0 580s Starting 2 pkgProblemResolver with broken count: 0 580s Done 582s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 582s autopkgtest [12:02:31]: test guile-tests-concurrent-web-server: guile tests/concurrent-web-server.scm 582s autopkgtest [12:02:31]: test guile-tests-concurrent-web-server: [----------------------- 589s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 589s ;;; or pass the --no-auto-compile argument to disable. 589s ;;; compiling /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/concurrent-web-server.scm 589s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-BE-8-4.7/tmp/autopkgtest.7mb4OD/build.c6p/src/tests/concurrent-web-server.scm.go 589s Backtrace: 589s In ice-9/boot-9.scm: 589s 1755:12 7 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _) 589s In unknown file: 589s 6 (apply-smob/0 #) 589s In ice-9/boot-9.scm: 589s 724:2 5 (call-with-prompt _ _ #) 589s In ice-9/eval.scm: 589s 619:8 4 (_ #(#(#))) 589s In ice-9/boot-9.scm: 589s 2858:4 3 (save-module-excursion _) 589s 4408:12 2 (_) 589s In /tmp/autopkgtest.7mb4OD/build.c6p/src/tests/concurrent-web-server.scm: 589s 83:11 1 (_) 589s In unknown file: 589s 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 …) …) 589s 589s ERROR: In procedure bytevector->uint-list: 589s In procedure bytevector->uint-list: Wrong type (expecting an exact positive integer that divides the bytevector length): 4 590s autopkgtest [12:02:39]: test guile-tests-concurrent-web-server: -----------------------] 590s guile-tests-concurrent-web-server FAIL non-zero exit status 1 590s autopkgtest [12:02:39]: test guile-tests-concurrent-web-server: - - - - - - - - - - results - - - - - - - - - - 590s autopkgtest [12:02:39]: @@@@@@@@@@@@@@@@@@@@ summary 590s guile-tests-basic PASS 590s guile-tests-conditions PASS 590s guile-tests-channels PASS 590s guile-tests-foreign PASS 590s guile-tests-io-wakeup PASS 590s guile-tests-parameters PASS 590s guile-tests-preemption PASS 590s guile-tests-speedup PASS 590s guile-tests-timer-wheel PASS 590s guile-tests-ports PASS 590s guile-tests-concurrent-web-server FAIL non-zero exit status 1 594s nova [W] Using flock in prodstack7-s390x 594s Creating nova instance adt-questing-s390x-guile-fibers-20250506-115249-juju-7f2275-prod-proposed-migration-environment-15-76a3dcd9-7e2e-4c1f-9dcf-3b4b68c6cd9a from image adt/ubuntu-questing-s390x-server-20250506.img (UUID fef1f145-d219-47e4-a2ed-77b44eac0376)... 594s nova [W] Timed out waiting for e10db827-b6e0-449e-b4e8-603f0672ae58 to get deleted.