0s autopkgtest [13:06:13]: starting date and time: 2025-03-22 13:06:13+0000 0s autopkgtest [13:06:13]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [13:06:13]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.lnf5dd4j/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-4 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-17.secgroup --name adt-plucky-ppc64el-guile-fibers-20250322-130613-juju-7f2275-prod-proposed-migration-environment-2-84d49386-6fc0-4579-87d0-5df32571fc87 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 133s autopkgtest [13:08:26]: testbed dpkg architecture: ppc64el 133s autopkgtest [13:08:26]: testbed apt version: 2.9.34 133s autopkgtest [13:08:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 134s autopkgtest [13:08:27]: testbed release detected to be: None 134s autopkgtest [13:08:27]: updating testbed package index (apt update) 135s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 135s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 135s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 135s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 135s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [29.9 kB] 135s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [1232 B] 135s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [288 kB] 136s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [11.5 kB] 136s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [42.1 kB] 136s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el c-n-f Metadata [1320 B] 136s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el c-n-f Metadata [120 B] 136s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [190 kB] 136s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el c-n-f Metadata [11.1 kB] 136s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3020 B] 136s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el c-n-f Metadata [316 B] 138s Fetched 704 kB in 1s (487 kB/s) 138s Reading package lists... 139s autopkgtest [13:08:32]: upgrading testbed (apt dist-upgrade and autopurge) 139s Reading package lists... 140s Building dependency tree... 140s Reading state information... 140s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 140s Starting 2 pkgProblemResolver with broken count: 0 140s Done 141s Entering ResolveByKeep 141s 142s Calculating upgrade... 142s The following packages will be upgraded: 142s ibverbs-providers libibverbs1 142s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Need to get 505 kB of archives. 142s After this operation, 0 B of additional disk space will be used. 142s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libibverbs1 ppc64el 56.0-3ubuntu1 [74.1 kB] 142s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el ibverbs-providers ppc64el 56.0-3ubuntu1 [431 kB] 143s Fetched 505 kB in 1s (589 kB/s) 143s (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 ... 107156 files and directories currently installed.) 143s Preparing to unpack .../libibverbs1_56.0-3ubuntu1_ppc64el.deb ... 143s Unpacking libibverbs1:ppc64el (56.0-3ubuntu1) over (55.0-1ubuntu1) ... 143s Preparing to unpack .../ibverbs-providers_56.0-3ubuntu1_ppc64el.deb ... 143s Unpacking ibverbs-providers:ppc64el (56.0-3ubuntu1) over (55.0-1ubuntu1) ... 143s Setting up libibverbs1:ppc64el (56.0-3ubuntu1) ... 143s Setting up ibverbs-providers:ppc64el (56.0-3ubuntu1) ... 144s Processing triggers for libc-bin (2.41-1ubuntu2) ... 144s Reading package lists... 144s Building dependency tree... 144s Reading state information... 144s Starting pkgProblemResolver with broken count: 0 145s Starting 2 pkgProblemResolver with broken count: 0 145s Done 145s Solving dependencies... 145s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s autopkgtest [13:08:41]: testbed running kernel: Linux 6.14.0-11-generic #11-Ubuntu SMP Mon Mar 17 12:33:11 UTC 2025 148s autopkgtest [13:08:41]: @@@@@@@@@@@@@@@@@@@@ apt-source guile-fibers 150s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe guile-fibers 1.3.1-4 (dsc) [2405 B] 150s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe guile-fibers 1.3.1-4 (tar) [581 kB] 150s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe guile-fibers 1.3.1-4 (diff) [4516 B] 150s gpgv: Signature made Thu Feb 20 07:20:23 2025 UTC 150s gpgv: using EDDSA key A3CC9C870B9D310ABAD4CF2F51722B08FE4745A2 150s gpgv: issuer "simon@josefsson.org" 150s gpgv: Can't check signature: No public key 150s dpkg-source: warning: cannot verify inline signature for ./guile-fibers_1.3.1-4.dsc: no acceptable signature found 150s autopkgtest [13:08:43]: testing package guile-fibers version 1.3.1-4 151s autopkgtest [13:08:44]: build not needed 152s autopkgtest [13:08:45]: test guile-tests-basic: preparing testbed 152s Reading package lists... 153s Building dependency tree... 153s Reading state information... 153s Starting pkgProblemResolver with broken count: 0 153s Starting 2 pkgProblemResolver with broken count: 0 153s Done 153s The following NEW packages will be installed: 153s guile-3.0 guile-3.0-libs guile-fibers libgc1 153s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 153s Need to get 8406 kB of archives. 153s After this operation, 60.3 MB of additional disk space will be used. 153s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libgc1 ppc64el 1:8.2.8-1 [112 kB] 154s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ppc64el guile-3.0-libs ppc64el 3.0.10+really3.0.10-4 [7946 kB] 155s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ppc64el guile-3.0 ppc64el 3.0.10+really3.0.10-4 [16.4 kB] 155s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el guile-fibers ppc64el 1.3.1-4 [332 kB] 155s Fetched 8406 kB in 2s (4257 kB/s) 155s Selecting previously unselected package libgc1:ppc64el. 156s (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 ... 107156 files and directories currently installed.) 156s Preparing to unpack .../libgc1_1%3a8.2.8-1_ppc64el.deb ... 156s Unpacking libgc1:ppc64el (1:8.2.8-1) ... 156s Selecting previously unselected package guile-3.0-libs:ppc64el. 156s Preparing to unpack .../guile-3.0-libs_3.0.10+really3.0.10-4_ppc64el.deb ... 156s Unpacking guile-3.0-libs:ppc64el (3.0.10+really3.0.10-4) ... 156s Selecting previously unselected package guile-3.0. 156s Preparing to unpack .../guile-3.0_3.0.10+really3.0.10-4_ppc64el.deb ... 156s Unpacking guile-3.0 (3.0.10+really3.0.10-4) ... 156s Selecting previously unselected package guile-fibers. 156s Preparing to unpack .../guile-fibers_1.3.1-4_ppc64el.deb ... 156s Unpacking guile-fibers (1.3.1-4) ... 156s Setting up libgc1:ppc64el (1:8.2.8-1) ... 156s Setting up guile-3.0-libs:ppc64el (3.0.10+really3.0.10-4) ... 156s Setting up guile-3.0 (3.0.10+really3.0.10-4) ... 156s update-alternatives: using /usr/lib/powerpc64le-linux-gnu/guile/3.0/bin/guile to provide /usr/bin/guile (guile) in auto mode 156s Setting up guile-fibers (1.3.1-4) ... 156s Processing triggers for libc-bin (2.41-1ubuntu2) ... 156s Processing triggers for man-db (2.13.0-1) ... 157s Processing triggers for install-info (7.1.1-1) ... 158s autopkgtest [13:08:51]: test guile-tests-basic: guile tests/basic.scm 158s autopkgtest [13:08:51]: test guile-tests-basic: [----------------------- 162s assert #f equal to #f: ok 162s assert #t terminates: ok 162s assert (false-if-exception (begin (run-fibers) #t)) equal to #f: ok 163s assert terminates: (run-fibers (lambda () (sleep 1)) #:drain? #t): ok (1.002287148 s) 163s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (7.50637e-4 s) 163s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (7.0631e-4 s) 163s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (7.90764e-4 s) 163s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.003521511 s) 163s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.028327446 s) 163s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t)))) #:drain? #t): ok (0.317703352 s) 164s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t))) #:drain? #t): ok (0.324554528 s) 186s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4))) #:drain? #t): ok (22.706142188 s) 197s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber loop-to-1e4 #:parallel? #t))) #:drain? #t): ok (10.785431241 s) 198s assert terminates: (run-fibers (lambda () (do-times 1 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.01251262 s) 199s assert terminates: (run-fibers (lambda () (do-times 10 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.001884481 s) 200s assert terminates: (run-fibers (lambda () (do-times 100 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.003528914 s) 201s assert terminates: (run-fibers (lambda () (do-times 1000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.00988446 s) 202s assert terminates: (run-fibers (lambda () (do-times 10000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (1.091151201 s) 204s assert terminates: (run-fibers (lambda () (do-times 100000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (2.128850045 s) 218s assert terminates: (run-fibers (lambda () (do-times 1000000 (spawn-fiber (lambda () (sleep 1))))) #:drain? #t): ok (13.756422599 s) 219s assert terminates: (run-fibers (lambda () (spawn-fiber-tree 7 (lambda () (sleep 1)))) #:drain? #t): ok (1.070164993 s) 219s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5)) #:drain? #t): ok (9.94603e-4 s) 219s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50)) #:drain? #t): ok (0.001050192 s) 219s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500)) #:drain? #t): ok (0.005585765 s) 219s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000)) #:drain? #t): ok (0.051341334 s) 220s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 50000)) #:drain? #t): ok (0.521214421 s) 225s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 500000)) #:drain? #t): ok (4.921980297 s) 275s assert terminates: (run-fibers (lambda () (spawn-fiber-chain 5000000)) #:drain? #t): ok (49.960572204 s) 275s assert terminates: (run-fibers (lambda () (test-run-order 10)) #:parallelism 1 #:drain? #t): ok (0.012036754 s) 275s assert terminates: (run-fibers (lambda () (test-wakeup-order 10)) #:parallelism 1 #:drain? #t): ok (3.7225e-4 s) 275s assert terminates: (run-fibers (lambda () 1) #:drain? #t): ok (5.18954e-4 s) 275s assert run-fiber-return-vals equal to (1): ok 276s assert terminates: (run-fibers (lambda () (do-times 20 (check-sleep (random 1.0)))) #:drain? #t): assert sleep 0.020608996598312723s < actual 0.021059294s: #t (diff: 2.1849554855287923%) 276s assert sleep 0.03456686196908243s < actual 0.034649901s: #t (diff: 0.24022727603055083%) 276s assert sleep 0.061024566720115414s < actual 0.061423893s: #t (diff: 0.6543697093599471%) 276s assert sleep 0.11746097407324547s < actual 0.117590839s: #t (diff: 0.11056006284567964%) 276s assert sleep 0.13706411233780896s < actual 0.137534168s: #t (diff: 0.34294583328460715%) 276s assert sleep 0.2275100133355504s < actual 0.227720662s: #t (diff: 0.09258874427601764%) 276s assert sleep 0.23514019199674957s < actual 0.23557518s: #t (diff: 0.18499091948365765%) 276s assert sleep 0.3256129036589292s < actual 0.325831096s: #t (diff: 0.067009734141046%) 276s assert sleep 0.3507339219939192s < actual 0.350840948s: #t (diff: 0.03051487163613109%) 276s assert sleep 0.36970041583284435s < actual 0.370293104s: #t (diff: 0.160315796729752%) 276s assert sleep 0.5002849968690339s < actual 0.500875203s: #t (diff: 0.1179739817623512%) 276s assert sleep 0.6727431540500131s < actual 0.672779351s: #t (diff: 0.005380500681277814%) 276s assert sleep 0.7000185262935479s < actual 0.700100504s: #t (diff: 0.01171079098237367%) 276s assert sleep 0.7148624304124437s < actual 0.71519364s: #t (diff: 0.046331933735164574%) 276s assert sleep 0.721997240644088s < actual 0.722060177s: #t (diff: 0.008716980116972537%) 276s assert sleep 0.7233843607837082s < actual 0.723597855s: #t (diff: 0.02951324743328717%) 276s assert sleep 0.7603254888022394s < actual 0.760853666s: #t (diff: 0.0694672486375159%) 276s assert sleep 0.8067622687831747s < actual 0.806972083s: #t (diff: 0.026006944665591437%) 276s assert sleep 0.9299942644443119s < actual 0.930322839s: #t (diff: 0.035330815280292256%) 276s assert sleep 0.999598330708636s < actual 0.999959173s: #t (diff: 0.03609872888725292%) 276s ok (1.004296987 s) 276s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 276s ;;; or pass the --no-auto-compile argument to disable. 276s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/basic.scm 276s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 276s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/basic.scm.go 276s WARNING: (tests basic): imported module (fibers) overrides core binding `sleep' 276s autopkgtest [13:10:49]: test guile-tests-basic: -----------------------] 276s autopkgtest [13:10:49]: test guile-tests-basic: - - - - - - - - - - results - - - - - - - - - - 276s guile-tests-basic PASS 277s autopkgtest [13:10:50]: test guile-tests-conditions: preparing testbed 277s Reading package lists... 277s Building dependency tree... 277s Reading state information... 277s Starting pkgProblemResolver with broken count: 0 277s Starting 2 pkgProblemResolver with broken count: 0 277s Done 278s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 279s autopkgtest [13:10:52]: test guile-tests-conditions: guile tests/conditions.scm 279s autopkgtest [13:10:52]: test guile-tests-conditions: [----------------------- 281s assert (condition? cv) equal to #t: ok 281s assert run-fibers on (wait/timeout cv) terminates: ok (0.052240964 s) 281s assert run-fiber-return-vals equal to (#f): ok 281s assert run-fibers on (wait/timeout cv) terminates: ok (0.051228544 s) 281s assert run-fiber-return-vals equal to (#f): ok 281s assert (signal-condition! cv) equal to #t: ok 281s assert (signal-condition! cv) equal to #f: ok 281s assert run-fibers on (wait/timeout cv) terminates: ok (8.21175e-4 s) 281s assert run-fiber-return-vals equal to (#t): ok 281s assert run-fibers on (wait/timeout cv) terminates: ok (5.90996e-4 s) 281s assert run-fiber-return-vals equal to (#t): ok 281s assert run-fibers on (let ((cv (make-condition))) (spawn-fiber (lambda () (signal-condition! cv))) (wait cv) #t) terminates: ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 281s ;;; or pass the --no-auto-compile argument to disable. 281s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/conditions.scm 281s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/conditions.scm.go 281s ok (0.001307635 s) 281s assert run-fiber-return-vals equal to (#t): ok 281s 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 281s autopkgtest [13:10:54]: test guile-tests-conditions: -----------------------] 281s guile-tests-conditions PASS 281s autopkgtest [13:10:54]: test guile-tests-conditions: - - - - - - - - - - results - - - - - - - - - - 282s autopkgtest [13:10:55]: test guile-tests-channels: preparing testbed 282s Reading package lists... 282s Building dependency tree... 282s Reading state information... 282s Starting pkgProblemResolver with broken count: 0 282s Starting 2 pkgProblemResolver with broken count: 0 282s Done 283s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 284s autopkgtest [13:10:57]: test guile-tests-channels: guile tests/channels.scm 284s autopkgtest [13:10:57]: test guile-tests-channels: [----------------------- 285s assert run-fibers on (rpc 1) terminates: ok (0.001337049 s) 285s assert run-fiber-return-vals equal to (1): ok 289s assert run-fibers on (rpc-fib 24) terminates: ok (4.130328965 s) 289s assert run-fiber-return-vals equal to (75025): ok 289s assert run-fibers on (pingpong (current-processor-count) 1000) terminates: ok (0.047621807 s) 289s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 289s ;;; or pass the --no-auto-compile argument to disable. 289s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/channels.scm 289s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/channels.scm.go 290s autopkgtest [13:11:03]: test guile-tests-channels: -----------------------] 290s guile-tests-channels PASS 290s autopkgtest [13:11:03]: test guile-tests-channels: - - - - - - - - - - results - - - - - - - - - - 290s autopkgtest [13:11:03]: test guile-tests-foreign: preparing testbed 291s Reading package lists... 291s Building dependency tree... 291s Reading state information... 291s Starting pkgProblemResolver with broken count: 0 291s Starting 2 pkgProblemResolver with broken count: 0 291s Done 291s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 292s autopkgtest [13:11:05]: test guile-tests-foreign: guile tests/foreign.scm 292s autopkgtest [13:11:05]: test guile-tests-foreign: [----------------------- 293s assert #f equal to #f: ok 293s assert #t terminates: ok 294s assert (sleep 1) terminates: ok 295s assert (perform-operation (sleep-operation 1)) terminates: ok 295s assert (receive-from-fiber 42) equal to 42: ok 295s assert (send-to-fiber 42) equal to 42: ok 295s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 295s ;;; or pass the --no-auto-compile argument to disable. 295s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/foreign.scm 295s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 295s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/foreign.scm.go 295s WARNING: (tests foreign): imported module (fibers) overrides core binding `sleep' 296s autopkgtest [13:11:09]: test guile-tests-foreign: -----------------------] 296s autopkgtest [13:11:09]: test guile-tests-foreign: - - - - - - - - - - results - - - - - - - - - - 296s guile-tests-foreign PASS 297s autopkgtest [13:11:10]: test guile-tests-io-wakeup: preparing testbed 297s Reading package lists... 297s Building dependency tree... 297s Reading state information... 297s Starting pkgProblemResolver with broken count: 0 297s Starting 2 pkgProblemResolver with broken count: 0 297s Done 298s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 298s autopkgtest [13:11:11]: test guile-tests-io-wakeup: guile tests/io-wakeup.scm 298s autopkgtest [13:11:11]: test guile-tests-io-wakeup: [----------------------- 301s assert run-fibers on (readable/timeout? s) terminates: ok (0.051705116 s) 301s assert run-fiber-return-vals equal to (#t): ok 301s assert (readable/timeout? s) equal to #t: ok 301s assert run-fibers on (readable/timeout? A) terminates: ok (0.051229182 s) 301s assert run-fiber-return-vals equal to (#t): ok 301s assert (readable/timeout? A) equal to #t: ok 301s assert run-fibers on (writable/timeout? B) terminates: ok (7.99698e-4 s) 301s assert run-fiber-return-vals equal to (#f): ok 301s assert (writable/timeout? B) equal to #f: ok 301s assert run-fibers on (writable/timeout? B) terminates: ok (0.05104732 s) 301s assert run-fiber-return-vals equal to (#t): ok 301s assert run-fibers on (readable/timeout? A) terminates: ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 301s ;;; or pass the --no-auto-compile argument to disable. 301s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/io-wakeup.scm 301s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/io-wakeup.scm.go 301s ok (0.009408997 s) 301s assert run-fiber-return-vals equal to (#f): ok 301s autopkgtest [13:11:14]: test guile-tests-io-wakeup: -----------------------] 302s guile-tests-io-wakeup PASS 302s autopkgtest [13:11:15]: test guile-tests-io-wakeup: - - - - - - - - - - results - - - - - - - - - - 302s autopkgtest [13:11:15]: test guile-tests-parameters: preparing testbed 302s Reading package lists... 303s Building dependency tree... 303s Reading state information... 303s Starting pkgProblemResolver with broken count: 0 303s Starting 2 pkgProblemResolver with broken count: 0 303s Done 303s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 304s autopkgtest [13:11:17]: test guile-tests-parameters: guile tests/parameters.scm 304s autopkgtest [13:11:17]: test guile-tests-parameters: [----------------------- 306s assert run-fibers on (my-param) terminates: ok (0.00652005 s) 306s assert run-fiber-return-vals equal to (#f): ok 306s assert run-fibers on (rpc (my-param)) terminates: ok (6.06568e-4 s) 306s assert run-fiber-return-vals equal to (#f): ok 306s assert run-fibers on (rpc (begin (my-param 42) (my-param))) terminates: ok (5.22955e-4 s) 306s assert run-fiber-return-vals equal to (42): ok 306s assert run-fibers on (my-param) terminates: ok (5.0356e-4 s) 306s assert run-fiber-return-vals equal to (#f): ok 306s assert run-fibers on (begin (my-param 100) (rpc (my-param))) terminates: ok (5.13006e-4 s) 306s assert run-fiber-return-vals equal to (100): ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 306s ;;; or pass the --no-auto-compile argument to disable. 306s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/parameters.scm 306s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/parameters.scm.go 306s ok 306s assert run-fibers on (my-param) terminates: ok (4.63945e-4 s) 306s assert run-fiber-return-vals equal to (#f): ok 306s assert (my-param) equal to #f: ok 306s assert (begin (my-param (quote foo)) (my-param)) equal to foo: ok 306s assert run-fibers on (my-param) terminates: ok (4.41652e-4 s) 306s assert run-fiber-return-vals equal to (foo): ok 306s assert run-fibers on (rpc (my-param)) terminates: ok (5.26237e-4 s) 306s assert run-fiber-return-vals equal to (foo): ok 306s autopkgtest [13:11:19]: test guile-tests-parameters: -----------------------] 307s autopkgtest [13:11:20]: test guile-tests-parameters: - - - - - - - - - - results - - - - - - - - - - 307s guile-tests-parameters PASS 307s autopkgtest [13:11:20]: test guile-tests-preemption: preparing testbed 307s Reading package lists... 307s Building dependency tree... 307s Reading state information... 308s Starting pkgProblemResolver with broken count: 0 308s Starting 2 pkgProblemResolver with broken count: 0 308s Done 308s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 309s autopkgtest [13:11:22]: test guile-tests-preemption: guile tests/preemption.scm 309s autopkgtest [13:11:22]: test guile-tests-preemption: [----------------------- 312s assert run-fibers on (let lp ((n 0)) (when (< n 100000000) (lp (#{1+}# n)))) terminates: ok (2.492649822 s) 314s assert run-fibers on (race-until 100) terminates: ok (1.195271253 s) 314s assert run-fiber-return-vals equal to (100): ok 314s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 314s ;;; or pass the --no-auto-compile argument to disable. 314s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/preemption.scm 314s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/preemption.scm.go 314s autopkgtest [13:11:27]: test guile-tests-preemption: -----------------------] 314s guile-tests-preemption PASS 314s autopkgtest [13:11:27]: test guile-tests-preemption: - - - - - - - - - - results - - - - - - - - - - 315s autopkgtest [13:11:28]: test guile-tests-speedup: preparing testbed 315s Reading package lists... 315s Building dependency tree... 315s Reading state information... 315s Starting pkgProblemResolver with broken count: 0 315s Starting 2 pkgProblemResolver with broken count: 0 315s Done 316s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 316s autopkgtest [13:11:29]: test guile-tests-speedup: guile tests/speedup.scm 316s autopkgtest [13:11:29]: test guile-tests-speedup: [----------------------- 319s speedup for (do-times 100000 (spawn-fiber (lambda () #t) #:parallel? #t)): 0.325458939 s / 0.332944457 s = 0.9775172169332735x (2 cpus) 322s speedup for (do-times 40000 (spawn-fiber (lambda () (sleep 1)) #:parallel? #t)): 1.385804965 s / 1.248418629 s = 1.110048290540208x (2 cpus) 363s speedup for (do-times 100000 (spawn-fiber (lambda () (loop-to 10000)) #:parallel? #t)): 26.409847384 s / 14.683545311 s = 1.7986015519164422x (2 cpus) 412s speedup for (do-times 10000 (spawn-fiber (lambda () (loop-to 100000)) #:parallel? #t)): 35.275155935 s / 13.940688067 s = 2.5303740938370427x (2 cpus) 455s speedup for (do-times 1000 (spawn-fiber (lambda () (loop-to 1000000)) #:parallel? #t)): 28.878577332 s / 14.038908288 s = 2.057038677051866x (2 cpus) 474s speedup for (do-times 100000 (spawn-fiber (lambda () (alloc-to 4 1000)) #:parallel? #t)): 11.922252641 s / 7.360502577 s = 1.6197606775187465x (2 cpus) 493s speedup for (do-times 10000 (spawn-fiber (lambda () (alloc-to 4 10000)) #:parallel? #t)): 11.983541136 s / 6.992366111 s = 1.7138034458962557x (2 cpus) 514s speedup for (do-times 1000 (spawn-fiber (lambda () (alloc-to 4 100000)) #:parallel? #t)): 14.227344317 s / 6.986490379 s = 2.036407916593511x (2 cpus) 514s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 514s ;;; or pass the --no-auto-compile argument to disable. 514s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/speedup.scm 514s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 514s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/speedup.scm.go 514s WARNING: (tests speedup): imported module (fibers) overrides core binding `sleep' 515s autopkgtest [13:14:48]: test guile-tests-speedup: -----------------------] 515s guile-tests-speedup PASS 515s autopkgtest [13:14:48]: test guile-tests-speedup: - - - - - - - - - - results - - - - - - - - - - 515s autopkgtest [13:14:48]: test guile-tests-timer-wheel: preparing testbed 516s Reading package lists... 516s Building dependency tree... 516s Reading state information... 516s Starting pkgProblemResolver with broken count: 0 516s Starting 2 pkgProblemResolver with broken count: 0 516s Done 516s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 517s autopkgtest [13:14:50]: test guile-tests-timer-wheel: guile tests/timer-wheel.scm 517s autopkgtest [13:14:50]: test guile-tests-timer-wheel: [----------------------- 521s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 521s ;;; or pass the --no-auto-compile argument to disable. 521s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/timer-wheel.scm 521s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/timer-wheel.scm.go 521s autopkgtest [13:14:54]: test guile-tests-timer-wheel: -----------------------] 521s autopkgtest [13:14:54]: test guile-tests-timer-wheel: - - - - - - - - - - results - - - - - - - - - - 521s guile-tests-timer-wheel PASS 522s autopkgtest [13:14:55]: test guile-tests-ports: preparing testbed 522s Reading package lists... 522s Building dependency tree... 522s Reading state information... 522s Starting pkgProblemResolver with broken count: 0 522s Starting 2 pkgProblemResolver with broken count: 0 522s Done 523s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 524s autopkgtest [13:14:57]: test guile-tests-ports: guile tests/ports.scm 524s autopkgtest [13:14:57]: test guile-tests-ports: [----------------------- 530s 530s ;;; (listening-socket #) 530s 530s ;;; (listening-socket #) 530s 530s ;;; (listening-socket #) 530s 530s ;;; (listening-socket #) 530s 530s ;;; (listening-socket #) 530s 530s ;;; (listening-socket #) 530s 530s ;;; (accepted-connection (# . #(2 2130706433 46546))) 530s 530s ;;; (connected #(2 2130706433 5556)) 530s 530s ;;; (received "hello!") 530s 530s ;;; (echo "hello!") 530s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 530s ;;; or pass the --no-auto-compile argument to disable. 530s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/ports.scm 530s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 530s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/ports.scm.go 530s WARNING: (tests ports): imported module (fibers) overrides core binding `sleep' 530s success 530s autopkgtest [13:15:03]: test guile-tests-ports: -----------------------] 531s autopkgtest [13:15:04]: test guile-tests-ports: - - - - - - - - - - results - - - - - - - - - - 531s guile-tests-ports PASS 531s autopkgtest [13:15:04]: test guile-tests-concurrent-web-server: preparing testbed 531s Reading package lists... 532s Building dependency tree... 532s Reading state information... 532s Starting pkgProblemResolver with broken count: 0 532s Starting 2 pkgProblemResolver with broken count: 0 532s Done 532s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 533s autopkgtest [13:15:06]: test guile-tests-concurrent-web-server: guile tests/concurrent-web-server.scm 533s autopkgtest [13:15:06]: test guile-tests-concurrent-web-server: [----------------------- 539s ;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0 539s ;;; or pass the --no-auto-compile argument to disable. 539s ;;; compiling /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/concurrent-web-server.scm 539s ;;; compiled /home/ubuntu/.cache/guile/ccache/3.0-LE-8-4.7/tmp/autopkgtest.6sg2LI/build.wQk/src/tests/concurrent-web-server.scm.go 539s Backtrace: 539s In ice-9/boot-9.scm: 539s 1755:12 7 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _) 539s In unknown file: 539s 6 (apply-smob/0 #) 539s In ice-9/boot-9.scm: 539s 724:2 5 (call-with-prompt _ _ #) 539s In ice-9/eval.scm: 539s 619:8 4 (_ #(#(#))) 539s In ice-9/boot-9.scm: 539s 2858:4 3 (save-module-excursion _) 539s 4408:12 2 (_) 539s In /tmp/autopkgtest.6sg2LI/build.wQk/src/tests/concurrent-web-server.scm: 539s 83:11 1 (_) 539s In unknown file: 539s 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 …) …) 539s 539s ERROR: In procedure bytevector->uint-list: 539s In procedure bytevector->uint-list: Wrong type (expecting an exact positive integer that divides the bytevector length): 4 540s autopkgtest [13:15:13]: test guile-tests-concurrent-web-server: -----------------------] 540s guile-tests-concurrent-web-server FAIL non-zero exit status 1 540s autopkgtest [13:15:13]: test guile-tests-concurrent-web-server: - - - - - - - - - - results - - - - - - - - - - 541s autopkgtest [13:15:14]: @@@@@@@@@@@@@@@@@@@@ summary 541s guile-tests-basic PASS 541s guile-tests-conditions PASS 541s guile-tests-channels PASS 541s guile-tests-foreign PASS 541s guile-tests-io-wakeup PASS 541s guile-tests-parameters PASS 541s guile-tests-preemption PASS 541s guile-tests-speedup PASS 541s guile-tests-timer-wheel PASS 541s guile-tests-ports PASS 541s guile-tests-concurrent-web-server FAIL non-zero exit status 1 558s nova [W] Using flock in prodstack6-ppc64el 558s Creating nova instance adt-plucky-ppc64el-guile-fibers-20250322-130613-juju-7f2275-prod-proposed-migration-environment-2-84d49386-6fc0-4579-87d0-5df32571fc87 from image adt/ubuntu-plucky-ppc64el-server-20250322.img (UUID 8c6d15e1-2abf-4991-a719-890835523c0f)... 558s nova [W] Timed out waiting for 1d05339e-71f5-41a1-a95f-d47653068a00 to get deleted.