2026-01-26 08:29.47: New job: test ocsigen/lwt https://github.com/ocsigen/lwt.git#refs/pull/967/head (39371322622d036bb82580a89938abf482f0d8ac) (linux-x86_64:fedora-43-5.4_opam-2.5) Base: ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7 Opam project build To reproduce locally: git clone --recursive "https://github.com/ocsigen/lwt.git" && cd "lwt" && git fetch origin "refs/pull/967/head" && git reset --hard 39371322 cat > Dockerfile <<'END-OF-DOCKERFILE' FROM ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7 # fedora-43-5.4_opam-2.5 USER 1000:1000 ENV CLICOLOR_FORCE="1" ENV OPAMCOLOR="always" WORKDIR /src RUN sudo dnf install -y findutils RUN sudo ln -f /usr/bin/opam-2.5 /usr/bin/opam RUN opam init --reinit -ni RUN uname -rs && opam exec -- ocaml -version && opam --version WORKDIR /src RUN sudo chown opam /src RUN cd ~/opam-repository && (git cat-file -e 873cb18c37b308713d11ad3894c4bb78d73fb3e7 || git fetch origin master) && git reset -q --hard 873cb18c37b308713d11ad3894c4bb78d73fb3e7 && git log --no-decorate -n1 --oneline && opam update -u COPY --chown=1000:1000 lwt_runtime_events.opam lwt_retry.opam lwt_react.opam lwt_ppx__ppx_let_tests.opam lwt_ppx.opam lwt_direct.opam lwt.opam ./ RUN opam pin add -yn lwt_runtime_events.dev './' && \ opam pin add -yn lwt_retry.dev './' && \ opam pin add -yn lwt_react.dev './' && \ opam pin add -yn lwt_ppx__ppx_let_tests.dev './' && \ opam pin add -yn lwt_ppx.dev './' && \ opam pin add -yn lwt_direct.dev './' && \ opam pin add -yn lwt.dev './' RUN echo '(lang dune 3.0)' > './dune-project' ENV DEPS="base.v0.17.3 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base cppo.1.8.0 csexp.1.5.2 dune.3.21.0 dune-configurator.3.21.0 ocaml.5.4.0 ocaml-base-compiler.5.4.0 ocaml-compiler.5.4.0 ocaml-compiler-libs.v0.17.0 ocaml-config.3 ocaml-options-vanilla.1 ocaml_intrinsics_kernel.v0.17.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.1 ppx_here.v0.17.0 ppx_let.v0.17.1 ppxlib.0.37.0 react.1.2.2 sexplib0.v0.17.0 stdlib-shims.0.3.0 topkg.1.1.1" ENV CI="true" ENV OCAMLCI="true" RUN opam update --depexts && opam install --cli=2.5 --depext-only -y lwt_runtime_events.dev lwt_retry.dev lwt_react.dev lwt_ppx__ppx_let_tests.dev lwt_ppx.dev lwt_direct.dev lwt.dev $DEPS RUN opam install $DEPS COPY --chown=1000:1000 . /src RUN opam exec -- dune build @install @check @runtest && rm -rf _build END-OF-DOCKERFILE docker build . END-REPRO-BLOCK 2026-01-26 08:29.47: Using cache hint "ocsigen/lwt-ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7-fedora-43-5.4_opam-2.5-75ab778214f47ae1c2af4a869bf7c608" 2026-01-26 08:29.47: Using OBuilder spec: ((from ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7) (comment fedora-43-5.4_opam-2.5) (user (uid 1000) (gid 1000)) (env CLICOLOR_FORCE 1) (env OPAMCOLOR always) (workdir /src) (run (network host) (shell "sudo dnf install -y findutils")) (run (shell "sudo ln -f /usr/bin/opam-2.5 /usr/bin/opam")) (run (shell "opam init --reinit -ni")) (run (shell "uname -rs && opam exec -- ocaml -version && opam --version")) (workdir /src) (run (shell "sudo chown opam /src")) (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "cd ~/opam-repository && (git cat-file -e 873cb18c37b308713d11ad3894c4bb78d73fb3e7 || git fetch origin master) && git reset -q --hard 873cb18c37b308713d11ad3894c4bb78d73fb3e7 && git log --no-decorate -n1 --oneline && opam update -u")) (copy (src lwt_runtime_events.opam lwt_retry.opam lwt_react.opam lwt_ppx__ppx_let_tests.opam lwt_ppx.opam lwt_direct.opam lwt.opam) (dst ./)) (run (network host) (shell "opam pin add -yn lwt_runtime_events.dev './' && \ \nopam pin add -yn lwt_retry.dev './' && \ \nopam pin add -yn lwt_react.dev './' && \ \nopam pin add -yn lwt_ppx__ppx_let_tests.dev './' && \ \nopam pin add -yn lwt_ppx.dev './' && \ \nopam pin add -yn lwt_direct.dev './' && \ \nopam pin add -yn lwt.dev './'")) (run (network host) (shell "echo '(lang dune 3.0)' > './dune-project'")) (env DEPS "base.v0.17.3 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base cppo.1.8.0 csexp.1.5.2 dune.3.21.0 dune-configurator.3.21.0 ocaml.5.4.0 ocaml-base-compiler.5.4.0 ocaml-compiler.5.4.0 ocaml-compiler-libs.v0.17.0 ocaml-config.3 ocaml-options-vanilla.1 ocaml_intrinsics_kernel.v0.17.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.1 ppx_here.v0.17.0 ppx_let.v0.17.1 ppxlib.0.37.0 react.1.2.2 sexplib0.v0.17.0 stdlib-shims.0.3.0 topkg.1.1.1") (env CI true) (env OCAMLCI true) (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "opam update --depexts && opam install --cli=2.5 --depext-only -y lwt_runtime_events.dev lwt_retry.dev lwt_react.dev lwt_ppx__ppx_let_tests.dev lwt_ppx.dev lwt_direct.dev lwt.dev $DEPS")) (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "opam install $DEPS")) (copy (src .) (dst /src)) (run (shell "opam exec -- dune build @install @check @runtest && rm -rf _build")) ) 2026-01-26 08:29.47: Waiting for resource in pool OCluster 2026-01-26 08:29.48: Waiting for worker… 2026-01-26 08:29.48: Got resource from pool OCluster Building on eumache All commits already cached HEAD is now at 393713226 separate cloexec tests from the rest of unix tests (from ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7) Unable to find image 'ocaml/opam:fedora-43-ocaml-5.4@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7' locally docker.io/ocaml/opam@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7: Pulling from ocaml/opam 1216d224fefc: Already exists d2b80d0f9692: Already exists b44754d8bf82: Already exists 36abc5888bbf: Already exists 13ceeda275e3: Already exists 9d0a0e279caf: Already exists 40e2d63e6bc8: Already exists 75b3ac574ea6: Already exists 1049f777ea82: Already exists 03fc9df51c6a: Already exists b047e90b13a5: Already exists 9e9b975180f0: Already exists 67d0d0d5c8c1: Already exists 89a5d6bde7a7: Already exists 1d93c1211989: Already exists 29eae7cc87b0: Already exists 29eae7cc87b0: Already exists cbc0891b6ad5: Already exists 1dcdb5dba4d6: Already exists cbbbe6830481: Already exists 21e1ea572da2: Already exists 4f4fb700ef54: Already exists 98b69470db28: Already exists 2dcdfd57803f: Already exists 379ef38822e9: Already exists 3bc4f9dcff1f: Already exists d9698ccc8ea7: Already exists 5ed663178eca: Already exists c8305c642087: Already exists 8f6d93fd556f: Already exists 921519ed1807: Already exists c60d13ca69bb: Already exists 2aac9c9633a8: Already exists c0e95d961175: Already exists 27ce8579a8e4: Already exists fe5862feaa51: Already exists e29132ca7758: Already exists 7f1e364d449b: Already exists a8bd8d8144bc: Already exists 571a3efac70d: Already exists a83a90a79bde: Already exists 965ec293f8c1: Already exists 98102c35b6c5: Already exists be27aa16171d: Already exists c900362c76d3: Already exists Digest: sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7 Status: Downloaded newer image for ocaml/opam@sha256:e63cb54f263f69a5487a22bff4673effded4c57d56bd27fd67e3cc2615aab9b7 2026-01-26 08:29.49 ---> using "4e2b8591845136281b2629afb7934c15f1ae534ce6c700ee8841e11b607a33a7" from cache /: (comment fedora-43-5.4_opam-2.5) /: (user (uid 1000) (gid 1000)) /: (env CLICOLOR_FORCE 1) /: (env OPAMCOLOR always) /: (workdir /src) /src: (run (network host) (shell "sudo dnf install -y findutils")) Updating and loading repositories: Fedora 43 - x86_64 100% | 40.4 KiB/s | 22.8 KiB | 00m01s Fedora 43 openh264 (From Cisco) - x86_ 100% | 3.4 KiB/s | 986.0 B | 00m00s Fedora 43 - x86_64 - Updates 100% | 98.3 KiB/s | 17.3 KiB | 00m00s Repositories loaded. Package "findutils-1:4.10.0-6.fc43.x86_64" is already installed. Nothing to do. 2026-01-26 08:29.49 ---> using "837c07188bf50ea546afbccb4d2f64bc0404968bc0937813826ca26b88c6ea71" from cache /src: (run (shell "sudo ln -f /usr/bin/opam-2.5 /usr/bin/opam")) 2026-01-26 08:29.49 ---> using "a0e1ae1c42dd01ffe431135132f32b5d6f97bc76e97c00f10122bcde345422b4" from cache /src: (run (shell "opam init --reinit -ni")) Configuring from /home/opam/.opamrc and then from built-in defaults. Checking for available remotes: rsync and local, git. - you won't be able to use mercurial repositories unless you install the hg command on your system. - you won't be able to use darcs repositories unless you install the darcs command on your system. This version of opam requires an update to the layout of /home/opam/.opam from version 2.0 to version 2.2, which can't be reverted. You may want to back it up before going further. Continue? [Y/n] y Format upgrade done. <><> Updating repositories ><><><><><><><><><><><><><><><><><><><><><><><><><><> [default] Initialised 2026-01-26 08:29.49 ---> using "61a7774f29dc5820513e99ec972f57df997429bf3f81ba129e961d9c42ee9cf0" from cache /src: (run (shell "uname -rs && opam exec -- ocaml -version && opam --version")) Linux 5.15.0-131-generic The OCaml toplevel, version 5.4.0 2.5.0 2026-01-26 08:29.49 ---> using "63917ca5af84f6109637526de6c22761387273cdcaa1b1d885dc1d45fbb1fa8b" from cache /src: (workdir /src) /src: (run (shell "sudo chown opam /src")) 2026-01-26 08:29.49 ---> using "26df678581fbe1125840d6b3260cbe14d9d438bec832027001047372311489df" from cache /src: (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "cd ~/opam-repository && (git cat-file -e 873cb18c37b308713d11ad3894c4bb78d73fb3e7 || git fetch origin master) && git reset -q --hard 873cb18c37b308713d11ad3894c4bb78d73fb3e7 && git log --no-decorate -n1 --oneline && opam update -u")) From https://github.com/ocaml/opam-repository * branch master -> FETCH_HEAD a6b2f19780..8e1b9a49e8 master -> origin/master 873cb18c37 Merge pull request #29216 from shonfeder/release-dune-3.21.0 <><> Updating package repositories ><><><><><><><><><><><><><><><><><><><><><><> [default] synchronised from git+file:///home/opam/opam-repository Already up-to-date. Nothing to do. # To update the current shell environment, run: eval $(opam env) 2026-01-26 08:29.49 ---> using "49b37028defa538922886761feef9a46e2c85e832a643652757c45819caa9f86" from cache /src: (copy (src lwt_runtime_events.opam lwt_retry.opam lwt_react.opam lwt_ppx__ppx_let_tests.opam lwt_ppx.opam lwt_direct.opam lwt.opam) (dst ./)) 2026-01-26 08:29.49 ---> saved as "935d9e2d279c0db97293b67962f9a1daa0dd00194609ffdd7eb1fbae8745d04d" /src: (run (network host) (shell "opam pin add -yn lwt_runtime_events.dev './' && \ \nopam pin add -yn lwt_retry.dev './' && \ \nopam pin add -yn lwt_react.dev './' && \ \nopam pin add -yn lwt_ppx__ppx_let_tests.dev './' && \ \nopam pin add -yn lwt_ppx.dev './' && \ \nopam pin add -yn lwt_direct.dev './' && \ \nopam pin add -yn lwt.dev './'")) [lwt_runtime_events.dev] synchronised (file:///src) lwt_runtime_events is now pinned to file:///src (version dev) [lwt_retry.dev] synchronised (file:///src) lwt_retry is now pinned to file:///src (version dev) [lwt_react.dev] synchronised (file:///src) lwt_react is now pinned to file:///src (version dev) [NOTE] Package lwt_ppx__ppx_let_tests does not exist in opam repositories registered in the current switch. [lwt_ppx__ppx_let_tests.dev] synchronised (file:///src) [WARNING] Failed checks on lwt_ppx__ppx_let_tests package definition from source at file:///src: warning 62: License doesn't adhere to the SPDX standard, see https://spdx.org/licenses/ : "NOTFORRELEASE" lwt_ppx__ppx_let_tests is now pinned to file:///src (version dev) [lwt_ppx.dev] synchronised (file:///src) lwt_ppx is now pinned to file:///src (version dev) [lwt_direct.dev] synchronised (file:///src) lwt_direct is now pinned to file:///src (version dev) [lwt.dev] synchronised (file:///src) lwt is now pinned to file:///src (version dev) 2026-01-26 08:29.55 ---> saved as "5399f22862e1ca4607d0ab5028b72566e315c3dcf715cfda63b43062d3326a7a" /src: (run (network host) (shell "echo '(lang dune 3.0)' > './dune-project'")) 2026-01-26 08:29.56 ---> saved as "a2bcec8219e2543d823089e65fffb90136fd72496efa9f3cc5bb0205e891bea2" /src: (env DEPS "base.v0.17.3 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base cppo.1.8.0 csexp.1.5.2 dune.3.21.0 dune-configurator.3.21.0 ocaml.5.4.0 ocaml-base-compiler.5.4.0 ocaml-compiler.5.4.0 ocaml-compiler-libs.v0.17.0 ocaml-config.3 ocaml-options-vanilla.1 ocaml_intrinsics_kernel.v0.17.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.1 ppx_here.v0.17.0 ppx_let.v0.17.1 ppxlib.0.37.0 react.1.2.2 sexplib0.v0.17.0 stdlib-shims.0.3.0 topkg.1.1.1") /src: (env CI true) /src: (env OCAMLCI true) /src: (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "opam update --depexts && opam install --cli=2.5 --depext-only -y lwt_runtime_events.dev lwt_retry.dev lwt_react.dev lwt_ppx__ppx_let_tests.dev lwt_ppx.dev lwt_direct.dev lwt.dev $DEPS")) + /usr/sbin/sudo "yum" "makecache" - Updating and loading repositories: - Fedora 43 - x86_64 - Updates 100% | 17.5 KiB/s | 6.8 KiB | 00m00s - Repositories loaded. - Metadata cache created. <><> Synchronising pinned packages ><><><><><><><><><><><><><><><><><><><><><><> [lwt.dev] synchronised (file:///src) [lwt_direct.dev] synchronised (file:///src) [lwt_ppx.dev] synchronised (file:///src) [lwt_ppx__ppx_let_tests.dev] synchronised (file:///src) [lwt_react.dev] synchronised (file:///src) [lwt_retry.dev] synchronised (file:///src) [lwt_runtime_events.dev] synchronised (file:///src) [NOTE] Package ocaml-options-vanilla is already installed (current version is 1). [NOTE] Package ocaml-config is already installed (current version is 3). [NOTE] Package ocaml-compiler is already installed (current version is 5.4.0). [NOTE] Package ocaml-base-compiler is already installed (current version is 5.4.0). [NOTE] Package ocaml is already installed (current version is 5.4.0). [NOTE] Package base-unix is already installed (current version is base). [NOTE] Package base-threads is already installed (current version is base). [NOTE] Package base-nnp is already installed (current version is base). [NOTE] Package base-effects is already installed (current version is base). [NOTE] Package base-domains is already installed (current version is base). [NOTE] Package base-bigarray is already installed (current version is base). # To update the current shell environment, run: eval $(opam env) 2026-01-26 08:30.08 ---> saved as "b631c82291c49e43f5e437059d253b2e9895b09c83f9787c8bbcef98b19f1646" /src: (run (cache (opam-archives (target /home/opam/.opam/download-cache))) (network host) (shell "opam install $DEPS")) [NOTE] Package ocaml-options-vanilla is already installed (current version is 1). [NOTE] Package ocaml-config is already installed (current version is 3). [NOTE] Package ocaml-compiler is already installed (current version is 5.4.0). [NOTE] Package ocaml-base-compiler is already installed (current version is 5.4.0). [NOTE] Package ocaml is already installed (current version is 5.4.0). [NOTE] Package base-unix is already installed (current version is base). [NOTE] Package base-threads is already installed (current version is base). [NOTE] Package base-nnp is already installed (current version is base). [NOTE] Package base-effects is already installed (current version is base). [NOTE] Package base-domains is already installed (current version is base). [NOTE] Package base-bigarray is already installed (current version is base). The following actions will be performed: === install 19 packages - install base v0.17.3 - install base-bytes base - install cppo 1.8.0 - install csexp 1.5.2 - install dune 3.21.0 - install dune-configurator 3.21.0 - install ocaml-compiler-libs v0.17.0 - install ocaml_intrinsics_kernel v0.17.1 - install ocamlbuild 0.16.1 - install ocamlfind 1.9.8 - install ocplib-endian 1.2 - install ppx_derivers 1.2.1 - install ppx_here v0.17.0 - install ppx_let v0.17.1 - install ppxlib 0.37.0 - install react 1.2.2 - install sexplib0 v0.17.0 - install stdlib-shims 0.3.0 - install topkg 1.1.1 <><> Processing actions <><><><><><><><><><><><><><><><><><><><><><><><><><><><> -> retrieved base.v0.17.3 (cached) -> retrieved cppo.1.8.0 (cached) -> retrieved csexp.1.5.2 (cached) -> retrieved ocaml-compiler-libs.v0.17.0 (cached) -> retrieved ocaml_intrinsics_kernel.v0.17.1 (cached) -> retrieved ocamlbuild.0.16.1 (cached) -> retrieved ocamlfind.1.9.8 (cached) -> retrieved ocplib-endian.1.2 (cached) -> retrieved ppx_derivers.1.2.1 (cached) -> retrieved ppx_here.v0.17.0 (cached) -> retrieved ppx_let.v0.17.1 (cached) -> retrieved react.1.2.2 (cached) -> retrieved sexplib0.v0.17.0 (cached) -> retrieved stdlib-shims.0.3.0 (cached) -> retrieved topkg.1.1.1 (cached) -> retrieved ppxlib.0.37.0 (cached) -> retrieved dune.3.21.0, dune-configurator.3.21.0 (cached) -> installed ocamlbuild.0.16.1 -> installed ocamlfind.1.9.8 -> installed base-bytes.base -> installed topkg.1.1.1 -> installed react.1.2.2 -> installed dune.3.21.0 -> installed ppx_derivers.1.2.1 -> installed csexp.1.5.2 -> installed cppo.1.8.0 -> installed ocaml-compiler-libs.v0.17.0 -> installed ocaml_intrinsics_kernel.v0.17.1 -> installed sexplib0.v0.17.0 -> installed stdlib-shims.0.3.0 -> installed ocplib-endian.1.2 -> installed dune-configurator.3.21.0 -> installed base.v0.17.3 -> installed ppxlib.0.37.0 -> installed ppx_here.v0.17.0 -> installed ppx_let.v0.17.1 Done. # To update the current shell environment, run: eval $(opam env) 2026-01-26 08:31.24 ---> saved as "695f9d1d90496889b4119e6eb85926637c10cbedacf94cbf6057b9eee91d2240" /src: (copy (src .) (dst /src)) 2026-01-26 08:31.24 ---> saved as "b14ca898792d46790b001ade6e830aefaccc2e2dbc1e69f44e6db4585560c3c8" /src: (run (shell "opam exec -- dune build @install @check @runtest && rm -rf _build")) (cd _build/default/test/direct && ./main.exe) Testing library 'lwt_direct'... ............. Ok. 13 tests ran, 0 tests skipped in 0.00 seconds [main] basic await [000.000]: starting [main] basic await [000.000]: finished in 0.000 s [main] await multiple values [000.000]: starting [main] await multiple values [000.000]: finished in 0.000 s [main] list.iter await [000.000]: starting [main] list.iter await [000.000]: finished in 0.000 s [main] lwt_list.iter_p spawn [000.000]: starting [main] lwt_list.iter_p spawn [000.000]: finished in 0.000 s [main] spawn in background [000.000]: starting [main] spawn in background [000.001]: finished in 0.000 s [main] list.iter await with yield [000.001]: starting [main] list.iter await with yield [000.001]: finished in 0.000 s [main] awaiting on failing promise [000.001]: starting [main] awaiting on failing promise [000.001]: finished in 0.000 s [main] spawn can fail [000.001]: starting [main] spawn can fail [000.001]: finished in 0.000 s [main] concurrent fib [000.001]: starting [main] concurrent fib [000.001]: finished in 0.000 s [storage] get set [000.001]: starting [storage] get set [000.001]: finished in 0.000 s [storage] storage across await [000.001]: starting [storage] storage across await [000.001]: finished in 0.000 s [io] read io [000.001]: starting [io] read io [000.001]: finished in 0.000 s [io] pipe [000.001]: starting [io] pipe [000.003]: finished in 0.002 s (cd _build/default/test/retry && ./main.exe) Testing library 'retry'... .............. Ok. 14 tests ran, 0 tests skipped in 0.01 seconds [lwt_retry] can format retries outcomes [000.000]: starting [lwt_retry] can format retries outcomes [000.000]: finished in 0.000 s [lwt_retry] can format fatal outcomes [000.000]: starting [lwt_retry] can format fatal outcomes [000.000]: finished in 0.000 s [lwt_retry] can format with default printer [000.000]: starting [lwt_retry] can format with default printer [000.000]: finished in 0.000 s [lwt_retry] success without retry [000.000]: starting [lwt_retry] success without retry [000.000]: finished in 0.000 s [lwt_retry] does not run extra attempts [000.000]: starting [lwt_retry] does not run extra attempts [000.000]: finished in 0.000 s [lwt_retry] just retries [000.000]: starting [lwt_retry] just retries [000.000]: finished in 0.000 s [lwt_retry] retries before fatal error [000.000]: starting [lwt_retry] retries before fatal error [000.000]: finished in 0.000 s [lwt_retry] retries before success [000.000]: starting [lwt_retry] retries before success [000.000]: finished in 0.000 s [lwt_retry] [n_times 0] runs one attempt [000.000]: starting [lwt_retry] [n_times 0] runs one attempt [000.000]: finished in 0.000 s [lwt_retry] n_times gives up on a fatal error [000.000]: starting [lwt_retry] n_times gives up on a fatal error [000.000]: finished in 0.000 s [lwt_retry] n_times gives a retry error when exhausted [000.000]: starting [lwt_retry] n_times gives a retry error when exhausted [000.000]: finished in 0.000 s [lwt_retry] n_times is ok on success [000.000]: starting [lwt_retry] n_times is ok on success [000.000]: finished in 0.000 s [lwt_retry] n_times on negative raises Invalid_argument [000.000]: starting [lwt_retry] n_times on negative raises Invalid_argument [000.000]: finished in 0.000 s [lwt_retry] with_sleep really does sleep [000.000]: starting [lwt_retry] with_sleep really does sleep [000.011]: finished in 0.010 s (cd _build/default/test/unix && ./cloexec.exe) Testing library 'unix.cloexec'... ..... Ok. 5 tests ran, 0 tests skipped in 0.02 seconds [lwt_unix.cloexec] openfile: O_CLOEXEC [000.000]: starting [lwt_unix.cloexec] openfile: O_CLOEXEC not given [000.000]: starting [lwt_unix.cloexec] openfile: O_KEEPEXEC [000.000]: starting [lwt_unix.cloexec] openfile: O_CLOEXEC, O_KEEPEXEC [000.000]: starting [lwt_unix.cloexec] openfile: O_KEEPEXEC, O_CLOEXEC [000.000]: starting [lwt_unix.cloexec] openfile: O_CLOEXEC not given [000.013]: finished in 0.013 s [lwt_unix.cloexec] openfile: O_CLOEXEC, O_KEEPEXEC [000.014]: finished in 0.013 s [lwt_unix.cloexec] openfile: O_CLOEXEC [000.017]: finished in 0.017 s [lwt_unix.cloexec] openfile: O_KEEPEXEC, O_CLOEXEC [000.018]: finished in 0.017 s [lwt_unix.cloexec] openfile: O_KEEPEXEC [000.019]: finished in 0.018 s (cd _build/default/test/core && ./main.exe) Testing library 'core'... ...............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................SSSSSSSSSSSSSSSSSSSSSSS.................................................................................................................................................. Ok. 705 tests ran, 23 tests skipped in 0.33 seconds [trivial promises] return [000.000]: starting [trivial promises] return [000.000]: finished in 0.000 s [trivial promises] reject [000.000]: starting [trivial promises] reject [000.000]: finished in 0.000 s [trivial promises] of_result: fulfilled [000.000]: starting [trivial promises] of_result: fulfilled [000.000]: finished in 0.000 s [trivial promises] of_result: rejected [000.000]: starting [trivial promises] of_result: rejected [000.000]: finished in 0.000 s [trivial promises] return_unit [000.000]: starting [trivial promises] return_unit [000.000]: finished in 0.000 s [trivial promises] return_true [000.000]: starting [trivial promises] return_true [000.000]: finished in 0.000 s [trivial promises] return_false [000.000]: starting [trivial promises] return_false [000.000]: finished in 0.000 s [trivial promises] return_none [000.000]: starting [trivial promises] return_none [000.000]: finished in 0.000 s [trivial promises] return_some [000.000]: starting [trivial promises] return_some [000.000]: finished in 0.000 s [trivial promises] return_ok [000.000]: starting [trivial promises] return_ok [000.000]: finished in 0.000 s [trivial promises] return_error [000.000]: starting [trivial promises] return_error [000.000]: finished in 0.000 s [trivial promises] fail_with [000.000]: starting [trivial promises] fail_with [000.000]: finished in 0.000 s [trivial promises] fail_invalid_arg [000.000]: starting [trivial promises] fail_invalid_arg [000.000]: finished in 0.000 s [initial promises] wait: pending [000.000]: starting [initial promises] wait: pending [000.000]: finished in 0.000 s [initial promises] task: pending [000.000]: starting [initial promises] task: pending [000.000]: finished in 0.000 s [initial promises] wait: fulfill [000.000]: starting [initial promises] wait: fulfill [000.000]: finished in 0.000 s [initial promises] task: fulfill [000.000]: starting [initial promises] task: fulfill [000.000]: finished in 0.000 s [initial promises] wait: reject [000.000]: starting [initial promises] wait: reject [000.000]: finished in 0.000 s [initial promises] task: reject [000.000]: starting [initial promises] task: reject [000.000]: finished in 0.000 s [initial promises] wait: resolve [000.000]: starting [initial promises] wait: resolve [000.001]: finished in 0.000 s [initial promises] task: resolve [000.001]: starting [initial promises] task: resolve [000.001]: finished in 0.000 s [double resolve] wakeup: double use on wait [000.001]: starting [double resolve] wakeup: double use on wait [000.001]: finished in 0.000 s [double resolve] wakeup: double use on task [000.001]: starting [double resolve] wakeup: double use on task [000.001]: finished in 0.000 s [double resolve] wakeup_exn: double use on wait [000.001]: starting [double resolve] wakeup_exn: double use on wait [000.001]: finished in 0.000 s [double resolve] wakeup_exn: double use on task [000.001]: starting [double resolve] wakeup_exn: double use on task [000.001]: finished in 0.000 s [double resolve] wakeup_result: double use on wait [000.001]: starting [double resolve] wakeup_result: double use on wait [000.001]: finished in 0.000 s [double resolve] wakeup_result: double use on task [000.001]: starting [double resolve] wakeup_result: double use on task [000.001]: finished in 0.000 s [bind] already fulfilled [000.001]: starting [bind] already fulfilled [000.001]: finished in 0.000 s [bind] already fulfilled, f raises [000.001]: starting [bind] already fulfilled, f raises [000.001]: finished in 0.000 s [bind] already rejected [000.001]: starting [bind] already rejected [000.001]: finished in 0.000 s [bind] pending [000.001]: starting [bind] pending [000.001]: finished in 0.000 s [bind] pending, fulfilled [000.001]: starting [bind] pending, fulfilled [000.001]: finished in 0.000 s [bind] pending, fulfilled, f raises [000.001]: starting [bind] pending, fulfilled, f raises [000.001]: finished in 0.000 s [bind] pending, rejected [000.001]: starting [bind] pending, rejected [000.001]: finished in 0.000 s [bind] chain [000.001]: starting [bind] chain [000.001]: finished in 0.000 s [bind] suspended chain [000.001]: starting [bind] suspended chain [000.001]: finished in 0.000 s [bind] fanout [000.001]: starting [bind] fanout [000.001]: finished in 0.000 s [bind] double pending [000.001]: starting [bind] double pending [000.001]: finished in 0.000 s [bind] same pending [000.001]: starting [bind] same pending [000.001]: finished in 0.000 s [bind] nested [000.001]: starting [bind] nested [000.001]: finished in 0.000 s [bind] proxy chain [000.001]: starting [bind] proxy chain [000.001]: finished in 0.000 s [bind] cycle [000.001]: starting [bind] cycle [000.001]: finished in 0.000 s [bind] proxy during callback [000.001]: starting [bind] proxy during callback [000.001]: finished in 0.000 s [backtrace_bind] fulfilled [000.001]: starting [backtrace_bind] fulfilled [000.001]: finished in 0.000 s [backtrace_bind] rejected [000.001]: starting [backtrace_bind] rejected [000.001]: finished in 0.000 s [backtrace_bind] pending, fulfilled [000.001]: starting [backtrace_bind] pending, fulfilled [000.001]: finished in 0.000 s [backtrace_bind] pending, fulfilled, f raises [000.001]: starting [backtrace_bind] pending, fulfilled, f raises [000.001]: finished in 0.000 s [backtrace_bind] pending, rejected [000.001]: starting [backtrace_bind] pending, rejected [000.001]: finished in 0.000 s [backtrace_bind] proxy during callback [000.001]: starting [backtrace_bind] proxy during callback [000.001]: finished in 0.000 s [map] fulfilled [000.001]: starting [map] fulfilled [000.001]: finished in 0.000 s [map] fulfilled, f raises [000.001]: starting [map] fulfilled, f raises [000.001]: finished in 0.000 s [map] rejected [000.001]: starting [map] rejected [000.001]: finished in 0.000 s [map] pending [000.001]: starting [map] pending [000.001]: finished in 0.000 s [map] pending, fulfilled [000.001]: starting [map] pending, fulfilled [000.001]: finished in 0.000 s [map] pending, fulfilled, f raises [000.001]: starting [map] pending, fulfilled, f raises [000.001]: finished in 0.000 s [map] pending, rejected [000.001]: starting [map] pending, rejected [000.001]: finished in 0.000 s [map] proxy during callback [000.001]: starting [map] proxy during callback [000.001]: finished in 0.000 s [catch] fulfilled [000.001]: starting [catch] fulfilled [000.001]: finished in 0.000 s [catch] f raises [000.001]: starting [catch] f raises [000.001]: finished in 0.000 s [catch] rejected [000.001]: starting [catch] rejected [000.002]: finished in 0.000 s [catch] rejected (raise) [000.002]: starting [catch] rejected (raise) [000.002]: finished in 0.000 s [catch] rejected, h raises [000.002]: starting [catch] rejected, h raises [000.002]: finished in 0.000 s [catch] pending [000.002]: starting [catch] pending [000.002]: finished in 0.000 s [catch] pending, fulfilled [000.002]: starting [catch] pending, fulfilled [000.002]: finished in 0.000 s [catch] pending, rejected [000.002]: starting [catch] pending, rejected [000.002]: finished in 0.000 s [catch] pending, rejected, h raises [000.002]: starting [catch] pending, rejected, h raises [000.002]: finished in 0.000 s [catch] pending, rejected, h pending [000.002]: starting [catch] pending, rejected, h pending [000.002]: finished in 0.000 s [catch] proxy during callback [000.002]: starting [catch] proxy during callback [000.002]: finished in 0.000 s [catch] catch with ocaml-runtime exception [000.002]: starting [catch] catch with ocaml-runtime exception [000.002]: finished in 0.000 s [catch] try_bind with ocaml-runtime exception [000.002]: starting [catch] try_bind with ocaml-runtime exception [000.002]: finished in 0.000 s [catch] try_bind(2) with ocaml-runtime exception [000.002]: starting [catch] try_bind(2) with ocaml-runtime exception [000.002]: finished in 0.000 s [backtrace_catch] fulfilled [000.002]: starting [backtrace_catch] fulfilled [000.002]: finished in 0.000 s [backtrace_catch] f raises [000.002]: starting [backtrace_catch] f raises [000.002]: finished in 0.000 s [backtrace_catch] rejected [000.002]: starting [backtrace_catch] rejected [000.002]: finished in 0.000 s [backtrace_catch] pending [000.002]: starting [backtrace_catch] pending [000.002]: finished in 0.000 s [backtrace_catch] pending, fulfilled [000.002]: starting [backtrace_catch] pending, fulfilled [000.002]: finished in 0.000 s [backtrace_catch] pending, rejected [000.002]: starting [backtrace_catch] pending, rejected [000.002]: finished in 0.000 s [backtrace_catch] pending, rejected, h raises [000.002]: starting [backtrace_catch] pending, rejected, h raises [000.002]: finished in 0.000 s [backtrace_catch] proxy during callback [000.002]: starting [backtrace_catch] proxy during callback [000.002]: finished in 0.000 s [try_bind] fulfilled [000.002]: starting [try_bind] fulfilled [000.002]: finished in 0.000 s [try_bind] fulfilled, f' raises [000.002]: starting [try_bind] fulfilled, f' raises [000.002]: finished in 0.000 s [try_bind] rejected [000.002]: starting [try_bind] rejected [000.002]: finished in 0.000 s [try_bind] f raises [000.002]: starting [try_bind] f raises [000.002]: finished in 0.000 s [try_bind] rejected, h raises [000.002]: starting [try_bind] rejected, h raises [000.002]: finished in 0.000 s [try_bind] pending [000.002]: starting [try_bind] pending [000.002]: finished in 0.000 s [try_bind] pending, fulfilled [000.002]: starting [try_bind] pending, fulfilled [000.002]: finished in 0.000 s [try_bind] pending, fulfilled, f' raises [000.002]: starting [try_bind] pending, fulfilled, f' raises [000.002]: finished in 0.000 s [try_bind] pending, fulfilled, f' pending [000.002]: starting [try_bind] pending, fulfilled, f' pending [000.002]: finished in 0.000 s [try_bind] pending, rejected [000.002]: starting [try_bind] pending, rejected [000.002]: finished in 0.000 s [try_bind] pending, rejected, h raises [000.002]: starting [try_bind] pending, rejected, h raises [000.002]: finished in 0.000 s [try_bind] pending, rejected, h pending [000.002]: starting [try_bind] pending, rejected, h pending [000.002]: finished in 0.000 s [try_bind] proxy during callback (fulfilled) [000.002]: starting [try_bind] proxy during callback (fulfilled) [000.002]: finished in 0.000 s [try_bind] proxy during callback (rejected) [000.002]: starting [try_bind] proxy during callback (rejected) [000.002]: finished in 0.000 s [backtrace_try_bind] fulfilled [000.002]: starting [backtrace_try_bind] fulfilled [000.002]: finished in 0.000 s [backtrace_try_bind] rejected [000.002]: starting [backtrace_try_bind] rejected [000.002]: finished in 0.000 s [backtrace_try_bind] f raises [000.002]: starting [backtrace_try_bind] f raises [000.002]: finished in 0.000 s [backtrace_try_bind] pending [000.002]: starting [backtrace_try_bind] pending [000.002]: finished in 0.000 s [backtrace_try_bind] pending, fulfilled [000.002]: starting [backtrace_try_bind] pending, fulfilled [000.002]: finished in 0.000 s [backtrace_try_bind] pending, fulfilled, f' raises [000.002]: starting [backtrace_try_bind] pending, fulfilled, f' raises [000.002]: finished in 0.000 s [backtrace_try_bind] pending, rejected [000.002]: starting [backtrace_try_bind] pending, rejected [000.003]: finished in 0.000 s [backtrace_try_bind] pending, rejected, h raises [000.003]: starting [backtrace_try_bind] pending, rejected, h raises [000.003]: finished in 0.000 s [backtrace_try_bind] proxy during callback (fulfilled) [000.003]: starting [backtrace_try_bind] proxy during callback (fulfilled) [000.003]: finished in 0.000 s [backtrace_try_bind] proxy during callback (rejected) [000.003]: starting [backtrace_try_bind] proxy during callback (rejected) [000.003]: finished in 0.000 s [finalize] fulfilled [000.003]: starting [finalize] fulfilled [000.003]: finished in 0.000 s [finalize] fulfilled, f' rejected [000.003]: starting [finalize] fulfilled, f' rejected [000.003]: finished in 0.000 s [finalize] fulfilled, f' raises [000.003]: starting [finalize] fulfilled, f' raises [000.003]: finished in 0.000 s [finalize] rejected [000.003]: starting [finalize] rejected [000.003]: finished in 0.000 s [finalize] rejected, f' rejected [000.003]: starting [finalize] rejected, f' rejected [000.003]: finished in 0.000 s [finalize] rejected, f' raises [000.003]: starting [finalize] rejected, f' raises [000.003]: finished in 0.000 s [finalize] pending [000.003]: starting [finalize] pending [000.003]: finished in 0.000 s [finalize] pending, fulfilled [000.003]: starting [finalize] pending, fulfilled [000.003]: finished in 0.000 s [finalize] pending, fulfilled, f' rejected [000.003]: starting [finalize] pending, fulfilled, f' rejected [000.003]: finished in 0.000 s [finalize] pending, fulfilled, f' raises [000.003]: starting [finalize] pending, fulfilled, f' raises [000.003]: finished in 0.000 s [finalize] pending, fulfilled, f' pending [000.003]: starting [finalize] pending, fulfilled, f' pending [000.003]: finished in 0.000 s [finalize] pending, fulfilled, f' pending, rejected [000.003]: starting [finalize] pending, fulfilled, f' pending, rejected [000.003]: finished in 0.000 s [finalize] pending, rejected [000.003]: starting [finalize] pending, rejected [000.003]: finished in 0.000 s [finalize] pending, rejected, f' rejected [000.003]: starting [finalize] pending, rejected, f' rejected [000.003]: finished in 0.000 s [finalize] pending, rejected, f' raises [000.003]: starting [finalize] pending, rejected, f' raises [000.003]: finished in 0.000 s [finalize] pending, rejected, f' pending [000.003]: starting [finalize] pending, rejected, f' pending [000.003]: finished in 0.000 s [finalize] pending, rejected, f' pending, rejected [000.003]: starting [finalize] pending, rejected, f' pending, rejected [000.003]: finished in 0.000 s [finalize] proxy during callback (fulfilled) [000.003]: starting [finalize] proxy during callback (fulfilled) [000.003]: finished in 0.000 s [finalize] proxy during callback (rejected) [000.003]: starting [finalize] proxy during callback (rejected) [000.003]: finished in 0.000 s [backtrace_finalize] fulfilled [000.003]: starting [backtrace_finalize] fulfilled [000.003]: finished in 0.000 s [backtrace_finalize] fulfilled, f' rejected [000.003]: starting [backtrace_finalize] fulfilled, f' rejected [000.003]: finished in 0.000 s [backtrace_finalize] fulfilled, f' raises [000.003]: starting [backtrace_finalize] fulfilled, f' raises [000.003]: finished in 0.000 s [backtrace_finalize] rejected [000.003]: starting [backtrace_finalize] rejected [000.003]: finished in 0.000 s [backtrace_finalize] rejected, f' rejected [000.003]: starting [backtrace_finalize] rejected, f' rejected [000.003]: finished in 0.000 s [backtrace_finalize] rejected, f' raises [000.003]: starting [backtrace_finalize] rejected, f' raises [000.003]: finished in 0.000 s [backtrace_finalize] pending [000.003]: starting [backtrace_finalize] pending [000.003]: finished in 0.000 s [backtrace_finalize] pending, fulfilled [000.003]: starting [backtrace_finalize] pending, fulfilled [000.003]: finished in 0.000 s [backtrace_finalize] pending, fulfilled, f' rejected [000.003]: starting [backtrace_finalize] pending, fulfilled, f' rejected [000.003]: finished in 0.000 s [backtrace_finalize] pending, fulfilled, f' raises [000.003]: starting [backtrace_finalize] pending, fulfilled, f' raises [000.003]: finished in 0.000 s [backtrace_finalize] pending, rejected [000.003]: starting [backtrace_finalize] pending, rejected [000.003]: finished in 0.000 s [backtrace_finalize] pending, rejected, f' rejected [000.003]: starting [backtrace_finalize] pending, rejected, f' rejected [000.003]: finished in 0.000 s [backtrace_finalize] pending, rejected, f' raises [000.003]: starting [backtrace_finalize] pending, rejected, f' raises [000.003]: finished in 0.000 s [backtrace_finalize] proxy during callback (fulfilled) [000.003]: starting [backtrace_finalize] proxy during callback (fulfilled) [000.003]: finished in 0.000 s [backtrace_finalize] proxy during callback (rejected) [000.003]: starting [backtrace_finalize] proxy during callback (rejected) [000.003]: finished in 0.000 s [on_success] fulfilled [000.003]: starting [on_success] fulfilled [000.003]: finished in 0.000 s [on_success] fulfilled, f raises [000.003]: starting [on_success] fulfilled, f raises [000.003]: finished in 0.000 s [on_success] rejected [000.003]: starting [on_success] rejected [000.004]: finished in 0.000 s [on_success] pending [000.004]: starting [on_success] pending [000.004]: finished in 0.000 s [on_success] pending, fulfilled [000.004]: starting [on_success] pending, fulfilled [000.004]: finished in 0.000 s [on_success] pending, fulfilled, f raises [000.004]: starting [on_success] pending, fulfilled, f raises [000.004]: finished in 0.000 s [on_success] pending, rejected [000.004]: starting [on_success] pending, rejected [000.004]: finished in 0.000 s [on_failure] fulfilled [000.004]: starting [on_failure] fulfilled [000.004]: finished in 0.000 s [on_failure] rejected [000.004]: starting [on_failure] rejected [000.004]: finished in 0.000 s [on_failure] rejected, f raises [000.004]: starting [on_failure] rejected, f raises [000.004]: finished in 0.000 s [on_failure] pending [000.004]: starting [on_failure] pending [000.004]: finished in 0.000 s [on_failure] pending, fulfilled [000.004]: starting [on_failure] pending, fulfilled [000.004]: finished in 0.000 s [on_failure] pending, rejected [000.004]: starting [on_failure] pending, rejected [000.004]: finished in 0.000 s [on_failure] pending, rejected, f raises [000.004]: starting [on_failure] pending, rejected, f raises [000.004]: finished in 0.000 s [on_termination] fulfilled [000.004]: starting [on_termination] fulfilled [000.004]: finished in 0.000 s [on_termination] fulfilled, f raises [000.004]: starting [on_termination] fulfilled, f raises [000.004]: finished in 0.000 s [on_termination] rejected [000.004]: starting [on_termination] rejected [000.004]: finished in 0.000 s [on_termination] rejected, f raises [000.004]: starting [on_termination] rejected, f raises [000.004]: finished in 0.000 s [on_termination] pending [000.004]: starting [on_termination] pending [000.004]: finished in 0.000 s [on_termination] pending, fulfilled [000.004]: starting [on_termination] pending, fulfilled [000.004]: finished in 0.000 s [on_termination] pending, fulfilled, f raises [000.004]: starting [on_termination] pending, fulfilled, f raises [000.004]: finished in 0.000 s [on_termination] pending, rejected [000.004]: starting [on_termination] pending, rejected [000.004]: finished in 0.000 s [on_termination] pending, rejected, f raises [000.004]: starting [on_termination] pending, rejected, f raises [000.004]: finished in 0.000 s [on_any] fulfilled [000.004]: starting [on_any] fulfilled [000.004]: finished in 0.000 s [on_any] fulfilled, f raises [000.004]: starting [on_any] fulfilled, f raises [000.004]: finished in 0.000 s [on_any] rejected [000.004]: starting [on_any] rejected [000.004]: finished in 0.000 s [on_any] rejected, f raises [000.004]: starting [on_any] rejected, f raises [000.004]: finished in 0.000 s [on_any] pending [000.004]: starting [on_any] pending [000.004]: finished in 0.000 s [on_any] pending, fulfilled [000.004]: starting [on_any] pending, fulfilled [000.004]: finished in 0.000 s [on_any] pending, fulfilled, f raises [000.004]: starting [on_any] pending, fulfilled, f raises [000.004]: finished in 0.000 s [on_any] pending, rejected [000.004]: starting [on_any] pending, rejected [000.004]: finished in 0.000 s [on_any] pending, rejected, g raises [000.004]: starting [on_any] pending, rejected, g raises [000.004]: finished in 0.000 s [async] fulfilled [000.004]: starting [async] fulfilled [000.004]: finished in 0.000 s [async] f raises [000.004]: starting [async] f raises [000.004]: finished in 0.000 s [async] rejected [000.004]: starting [async] rejected [000.004]: finished in 0.000 s [async] pending, fulfilled [000.004]: starting [async] pending, fulfilled [000.004]: finished in 0.000 s [async] pending, rejected [000.004]: starting [async] pending, rejected [000.004]: finished in 0.000 s [dont_wait] fulfilled [000.004]: starting [dont_wait] fulfilled [000.004]: finished in 0.000 s [dont_wait] f raises [000.004]: starting [dont_wait] f raises [000.004]: finished in 0.000 s [dont_wait] rejected [000.004]: starting [dont_wait] rejected [000.004]: finished in 0.000 s [dont_wait] pending, fulfilled [000.004]: starting [dont_wait] pending, fulfilled [000.004]: finished in 0.000 s [dont_wait] pending, rejected [000.004]: starting [dont_wait] pending, rejected [000.004]: finished in 0.000 s [ignore_result] fulfilled [000.004]: starting [ignore_result] fulfilled [000.004]: finished in 0.000 s [ignore_result] rejected [000.005]: starting [ignore_result] rejected [000.005]: finished in 0.000 s [ignore_result] pending, fulfilled [000.005]: starting [ignore_result] pending, fulfilled [000.005]: finished in 0.000 s [ignore_result] pending, rejected [000.005]: starting [ignore_result] pending, rejected [000.005]: finished in 0.000 s [join] empty [000.005]: starting [join] empty [000.005]: finished in 0.000 s [join] all fulfilled [000.005]: starting [join] all fulfilled [000.005]: finished in 0.000 s [join] all rejected [000.005]: starting [join] all rejected [000.005]: finished in 0.000 s [join] fulfilled and pending, fulfilled [000.005]: starting [join] fulfilled and pending, fulfilled [000.005]: finished in 0.000 s [join] rejected and pending, fulfilled [000.005]: starting [join] rejected and pending, fulfilled [000.005]: finished in 0.000 s [join] fulfilled and pending, rejected [000.005]: starting [join] fulfilled and pending, rejected [000.005]: finished in 0.000 s [join] rejected and pending, rejected [000.005]: starting [join] rejected and pending, rejected [000.005]: finished in 0.000 s [join] diamond [000.005]: starting [join] diamond [000.005]: finished in 0.000 s [all] empty [000.005]: starting [all] empty [000.005]: finished in 0.000 s [all] all fulfilled (one) [000.005]: starting [all] all fulfilled (one) [000.005]: finished in 0.000 s [all] all fulfilled (two) [000.005]: starting [all] all fulfilled (two) [000.005]: finished in 0.000 s [all] all fulfilled (three) [000.005]: starting [all] all fulfilled (three) [000.005]: finished in 0.000 s [all] all fulfilled (long) [000.005]: starting [all] all fulfilled (long) [000.005]: finished in 0.000 s [all] all rejected [000.005]: starting [all] all rejected [000.005]: finished in 0.000 s [all] fulfilled and pending, fulfilled [000.005]: starting [all] fulfilled and pending, fulfilled [000.005]: finished in 0.000 s [all] pending twice physically equal, fulfilled [000.005]: starting [all] pending twice physically equal, fulfilled [000.005]: finished in 0.000 s [all] pending twice physically equal twice, fulfilled [000.005]: starting [all] pending twice physically equal twice, fulfilled [000.005]: finished in 0.000 s [all] fulfilled and pending and fulfilled, fulfilled [000.005]: starting [all] fulfilled and pending and fulfilled, fulfilled [000.005]: finished in 0.000 s [all] fulfilled and pending, fulfilled (long) [000.005]: starting [all] fulfilled and pending, fulfilled (long) [000.005]: finished in 0.000 s [all] rejected and pending, fulfilled [000.005]: starting [all] rejected and pending, fulfilled [000.005]: finished in 0.000 s [all] fulfilled and pending, rejected [000.005]: starting [all] fulfilled and pending, rejected [000.005]: finished in 0.000 s [all] rejected and pending, rejected [000.005]: starting [all] rejected and pending, rejected [000.005]: finished in 0.000 s [all] diamond [000.005]: starting [all] diamond [000.005]: finished in 0.000 s [both] both fulfilled [000.005]: starting [both] both fulfilled [000.005]: finished in 0.000 s [both] both rejected [000.005]: starting [both] both rejected [000.005]: finished in 0.000 s [both] rejected, fulfilled [000.005]: starting [both] rejected, fulfilled [000.005]: finished in 0.000 s [both] fulfilled, rejected [000.005]: starting [both] fulfilled, rejected [000.005]: finished in 0.000 s [both] both pending [000.005]: starting [both] both pending [000.005]: finished in 0.000 s [both] pending, fulfilled [000.005]: starting [both] pending, fulfilled [000.005]: finished in 0.000 s [both] pending, rejected [000.005]: starting [both] pending, rejected [000.005]: finished in 0.000 s [both] fulfilled, pending [000.005]: starting [both] fulfilled, pending [000.005]: finished in 0.000 s [both] rejected, pending [000.005]: starting [both] rejected, pending [000.005]: finished in 0.000 s [both] pending, fulfilled, then fulfilled [000.005]: starting [both] pending, fulfilled, then fulfilled [000.005]: finished in 0.000 s [both] pending, rejected, then fulfilled [000.005]: starting [both] pending, rejected, then fulfilled [000.005]: finished in 0.000 s [both] pending, fulfilled, then rejected [000.005]: starting [both] pending, fulfilled, then rejected [000.005]: finished in 0.000 s [both] pending, rejected, then rejected [000.005]: starting [both] pending, rejected, then rejected [000.005]: finished in 0.000 s [both] fulfilled, pending, then fulfilled [000.005]: starting [both] fulfilled, pending, then fulfilled [000.006]: finished in 0.000 s [both] rejected, pending, then fulfilled [000.006]: starting [both] rejected, pending, then fulfilled [000.006]: finished in 0.000 s [both] fulfilled, pending, then rejected [000.006]: starting [both] fulfilled, pending, then rejected [000.006]: finished in 0.000 s [both] rejected, pending, then rejected [000.006]: starting [both] rejected, pending, then rejected [000.006]: finished in 0.000 s [both] pending, then first fulfilled [000.006]: starting [both] pending, then first fulfilled [000.006]: finished in 0.000 s [both] pending, then first rejected [000.006]: starting [both] pending, then first rejected [000.006]: finished in 0.000 s [both] pending, then second fulfilled [000.006]: starting [both] pending, then second fulfilled [000.006]: finished in 0.000 s [both] pending, then second rejected [000.006]: starting [both] pending, then second rejected [000.006]: finished in 0.000 s [both] pending, then first fulfilled, then fulfilled [000.006]: starting [both] pending, then first fulfilled, then fulfilled [000.006]: finished in 0.000 s [both] pending, then first fulfilled, then rejected [000.006]: starting [both] pending, then first fulfilled, then rejected [000.006]: finished in 0.000 s [both] pending, then first rejected, then fulfilled [000.006]: starting [both] pending, then first rejected, then fulfilled [000.006]: finished in 0.000 s [both] pending, then first rejected, then rejected [000.006]: starting [both] pending, then first rejected, then rejected [000.006]: finished in 0.000 s [both] pending, then second fulfilled, then fulfilled [000.006]: starting [both] pending, then second fulfilled, then fulfilled [000.006]: finished in 0.000 s [both] pending, then second fulfilled, then rejected [000.006]: starting [both] pending, then second fulfilled, then rejected [000.006]: finished in 0.000 s [both] pending, then second rejected, then fulfilled [000.006]: starting [both] pending, then second rejected, then fulfilled [000.006]: finished in 0.000 s [both] pending, then second rejected, then rejected [000.006]: starting [both] pending, then second rejected, then rejected [000.006]: finished in 0.000 s [both] diamond [000.006]: starting [both] diamond [000.006]: finished in 0.000 s [choose] empty [000.006]: starting [choose] empty [000.006]: finished in 0.000 s [choose] fulfilled [000.006]: starting [choose] fulfilled [000.006]: finished in 0.000 s [choose] rejected [000.006]: starting [choose] rejected [000.006]: finished in 0.000 s [choose] multiple resolved [000.006]: starting [choose] multiple resolved [000.006]: finished in 0.000 s [choose] pending [000.006]: starting [choose] pending [000.006]: finished in 0.000 s [choose] pending, fulfilled [000.006]: starting [choose] pending, fulfilled [000.006]: finished in 0.000 s [choose] diamond [000.006]: starting [choose] diamond [000.006]: finished in 0.000 s [nchoose] empty [000.006]: starting [nchoose] empty [000.006]: finished in 0.000 s [nchoose] all fulfilled [000.006]: starting [nchoose] all fulfilled [000.006]: finished in 0.000 s [nchoose] fulfilled, rejected [000.006]: starting [nchoose] fulfilled, rejected [000.006]: finished in 0.000 s [nchoose] rejected, fulfilled [000.006]: starting [nchoose] rejected, fulfilled [000.006]: finished in 0.000 s [nchoose] some pending [000.006]: starting [nchoose] some pending [000.006]: finished in 0.000 s [nchoose] pending, fulfilled [000.006]: starting [nchoose] pending, fulfilled [000.006]: finished in 0.000 s [nchoose] pending, rejected [000.006]: starting [nchoose] pending, rejected [000.006]: finished in 0.000 s [nchoose] diamond [000.006]: starting [nchoose] diamond [000.006]: finished in 0.000 s [nchoose] diamond, rejected [000.006]: starting [nchoose] diamond, rejected [000.006]: finished in 0.000 s [nchoose_split] empty [000.006]: starting [nchoose_split] empty [000.006]: finished in 0.000 s [nchoose_split] some fulfilled [000.006]: starting [nchoose_split] some fulfilled [000.006]: finished in 0.000 s [nchoose_split] fulfilled, rejected [000.006]: starting [nchoose_split] fulfilled, rejected [000.006]: finished in 0.000 s [nchoose_split] rejected, fulfilled [000.006]: starting [nchoose_split] rejected, fulfilled [000.006]: finished in 0.000 s [nchoose_split] pending, rejected [000.006]: starting [nchoose_split] pending, rejected [000.006]: finished in 0.000 s [nchoose_split] pending, fulfilled [000.006]: starting [nchoose_split] pending, fulfilled [000.007]: finished in 0.000 s [nchoose_split] pending, rejected 2 [000.007]: starting [nchoose_split] pending, rejected 2 [000.007]: finished in 0.000 s [nchoose_split] diamond [000.007]: starting [nchoose_split] diamond [000.007]: finished in 0.000 s [nchoose_split] diamond, rejected [000.007]: starting [nchoose_split] diamond, rejected [000.007]: finished in 0.000 s [state query] is_sleeping: fulfilled [000.007]: starting [state query] is_sleeping: fulfilled [000.007]: finished in 0.000 s [state query] is_sleeping: rejected [000.007]: starting [state query] is_sleeping: rejected [000.007]: finished in 0.000 s [state query] is_sleeping: pending [000.007]: starting [state query] is_sleeping: pending [000.007]: finished in 0.000 s [state query] is_sleeping: proxy [000.008]: starting [state query] is_sleeping: proxy [000.008]: finished in 0.000 s [state query] poll: fulfilled [000.008]: starting [state query] poll: fulfilled [000.008]: finished in 0.000 s [state query] poll: rejected [000.008]: starting [state query] poll: rejected [000.008]: finished in 0.000 s [state query] poll: pending [000.008]: starting [state query] poll: pending [000.008]: finished in 0.000 s [state query] poll: proxy [000.008]: starting [state query] poll: proxy [000.008]: finished in 0.000 s [wakeup] wakeup_result: nested [000.008]: starting [wakeup] wakeup_result: nested [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_result: immediate [000.008]: starting [wakeup_later] wakeup_later_result: immediate [000.008]: finished in 0.000 s [wakeup_later] wakeup_later: double use on wait [000.008]: starting [wakeup_later] wakeup_later: double use on wait [000.008]: finished in 0.000 s [wakeup_later] wakeup_later: double use on task [000.008]: starting [wakeup_later] wakeup_later: double use on task [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_result: double use on wait [000.008]: starting [wakeup_later] wakeup_later_result: double use on wait [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_result: double use on task [000.008]: starting [wakeup_later] wakeup_later_result: double use on task [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_exn: double use on wait [000.008]: starting [wakeup_later] wakeup_later_exn: double use on wait [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_exn: double use on task [000.008]: starting [wakeup_later] wakeup_later_exn: double use on task [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_result: nested [000.008]: starting [wakeup_later] wakeup_later_result: nested [000.008]: finished in 0.000 s [wakeup_later] wakeup_later: basic [000.008]: starting [wakeup_later] wakeup_later: basic [000.008]: finished in 0.000 s [wakeup_later] wakeup_later_exn: basic [000.008]: starting [wakeup_later] wakeup_later_exn: basic [000.008]: finished in 0.000 s [cancel] fulfilled [000.008]: starting [cancel] fulfilled [000.008]: finished in 0.000 s [cancel] rejected [000.008]: starting [cancel] rejected [000.008]: finished in 0.000 s [cancel] wait [000.008]: starting [cancel] wait [000.008]: finished in 0.000 s [cancel] task [000.008]: starting [cancel] task [000.008]: finished in 0.000 s [cancel] callback [000.008]: starting [cancel] callback [000.008]: finished in 0.000 s [cancel] nested [000.008]: starting [cancel] nested [000.008]: finished in 0.000 s [on_cancel] pending [000.008]: starting [on_cancel] pending [000.008]: finished in 0.000 s [on_cancel] multiple [000.008]: starting [on_cancel] multiple [000.008]: finished in 0.000 s [on_cancel] ordering [000.008]: starting [on_cancel] ordering [000.008]: finished in 0.000 s [on_cancel] fulfilled [000.008]: starting [on_cancel] fulfilled [000.008]: finished in 0.000 s [on_cancel] rejected [000.008]: starting [on_cancel] rejected [000.008]: finished in 0.000 s [on_cancel] already canceled [000.008]: starting [on_cancel] already canceled [000.008]: finished in 0.000 s [on_cancel] reject with Canceled [000.008]: starting [on_cancel] reject with Canceled [000.008]: finished in 0.000 s [protected] fulfilled [000.008]: starting [protected] fulfilled [000.008]: finished in 0.000 s [protected] rejected [000.008]: starting [protected] rejected [000.008]: finished in 0.000 s [protected] pending [000.008]: starting [protected] pending [000.008]: finished in 0.000 s [protected] pending, fulfilled [000.008]: starting [protected] pending, fulfilled [000.008]: finished in 0.000 s [protected] pending, canceled [000.008]: starting [protected] pending, canceled [000.008]: finished in 0.000 s [protected] pending, canceled, fulfilled [000.008]: starting [protected] pending, canceled, fulfilled [000.008]: finished in 0.000 s [protected] pending, proxy [000.008]: starting [protected] pending, proxy [000.008]: finished in 0.000 s [wrap_in_cancelable] fulfilled [000.008]: starting [wrap_in_cancelable] fulfilled [000.008]: finished in 0.000 s [wrap_in_cancelable] rejected [000.008]: starting [wrap_in_cancelable] rejected [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(task) [000.008]: starting [wrap_in_cancelable] pending(task) [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(task), fulfilled [000.008]: starting [wrap_in_cancelable] pending(task), fulfilled [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(task), canceled [000.008]: starting [wrap_in_cancelable] pending(task), canceled [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(wait) [000.008]: starting [wrap_in_cancelable] pending(wait) [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(wait), fulfilled [000.008]: starting [wrap_in_cancelable] pending(wait), fulfilled [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(wait), canceled [000.008]: starting [wrap_in_cancelable] pending(wait), canceled [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(task), canceled, fulfilled [000.008]: starting [wrap_in_cancelable] pending(task), canceled, fulfilled [000.008]: finished in 0.000 s [wrap_in_cancelable] pending(wait), canceled, fulfilled [000.009]: starting [wrap_in_cancelable] pending(wait), canceled, fulfilled [000.009]: finished in 0.000 s [wrap_in_cancelable] pending, proxy [000.009]: starting [wrap_in_cancelable] pending, proxy [000.009]: finished in 0.000 s [no_cancel] fulfilled [000.009]: starting [no_cancel] fulfilled [000.009]: finished in 0.000 s [no_cancel] rejected [000.009]: starting [no_cancel] rejected [000.009]: finished in 0.000 s [no_cancel] pending [000.009]: starting [no_cancel] pending [000.009]: finished in 0.000 s [no_cancel] pending, fulfilled [000.009]: starting [no_cancel] pending, fulfilled [000.009]: finished in 0.000 s [no_cancel] pending, cancel attempt [000.009]: starting [no_cancel] pending, cancel attempt [000.009]: finished in 0.000 s [resolve canceled] wakeup: canceled [000.009]: starting [resolve canceled] wakeup: canceled [000.009]: finished in 0.000 s [resolve canceled] wakeup_later: canceled [000.009]: starting [resolve canceled] wakeup_later: canceled [000.009]: finished in 0.000 s [pick] empty [000.009]: starting [pick] empty [000.009]: finished in 0.000 s [pick] fulfilled [000.009]: starting [pick] fulfilled [000.009]: finished in 0.000 s [pick] rejected [000.009]: starting [pick] rejected [000.009]: finished in 0.000 s [pick] multiple resolved [000.009]: starting [pick] multiple resolved [000.009]: finished in 0.000 s [pick] pending [000.009]: starting [pick] pending [000.009]: finished in 0.000 s [pick] pending, fulfilled [000.009]: starting [pick] pending, fulfilled [000.009]: finished in 0.000 s [pick] diamond [000.009]: starting [pick] diamond [000.009]: finished in 0.000 s [pick] pending, canceled [000.009]: starting [pick] pending, canceled [000.009]: finished in 0.000 s [pick] cancellation/resolution order [000.009]: starting [pick] cancellation/resolution order [000.009]: finished in 0.000 s [npick] empty [000.009]: starting [npick] empty [000.009]: finished in 0.000 s [npick] all fulfilled [000.009]: starting [npick] all fulfilled [000.009]: finished in 0.000 s [npick] fulfilled, rejected [000.009]: starting [npick] fulfilled, rejected [000.009]: finished in 0.000 s [npick] rejected, fulfilled [000.009]: starting [npick] rejected, fulfilled [000.009]: finished in 0.000 s [npick] some pending [000.009]: starting [npick] some pending [000.009]: finished in 0.000 s [npick] pending [000.009]: starting [npick] pending [000.009]: finished in 0.000 s [npick] pending, fulfilled [000.009]: starting [npick] pending, fulfilled [000.009]: finished in 0.000 s [npick] pending, rejected [000.009]: starting [npick] pending, rejected [000.009]: finished in 0.000 s [npick] diamond [000.009]: starting [npick] diamond [000.009]: finished in 0.000 s [npick] diamond, rejected [000.009]: starting [npick] diamond, rejected [000.009]: finished in 0.000 s [npick] pending, canceled [000.009]: starting [npick] pending, canceled [000.009]: finished in 0.000 s [npick] cancellation/resolution order [000.009]: starting [npick] cancellation/resolution order [000.009]: finished in 0.000 s [cancel bind] wait, pending, canceled [000.009]: starting [cancel bind] wait, pending, canceled [000.009]: finished in 0.000 s [cancel bind] task, pending, canceled [000.009]: starting [cancel bind] task, pending, canceled [000.009]: finished in 0.000 s [cancel bind] pending, wait, canceled [000.009]: starting [cancel bind] pending, wait, canceled [000.009]: finished in 0.000 s [cancel bind] pending, task, canceled [000.009]: starting [cancel bind] pending, task, canceled [000.009]: finished in 0.000 s [cancel bind] pending, task, canceled, chain [000.009]: starting [cancel bind] pending, task, canceled, chain [000.009]: finished in 0.000 s [cancel bind] pending, on_cancel callbacks [000.009]: starting [cancel bind] pending, on_cancel callbacks [000.009]: finished in 0.000 s [cancel bind] pending, fulfilled, on_cancel callbacks [000.009]: starting [cancel bind] pending, fulfilled, on_cancel callbacks [000.009]: finished in 0.000 s [cancel map] wait, pending, canceled [000.009]: starting [cancel map] wait, pending, canceled [000.009]: finished in 0.000 s [cancel map] task, pending, canceled [000.009]: starting [cancel map] task, pending, canceled [000.009]: finished in 0.000 s [cancel catch] wait, pending, canceled [000.009]: starting [cancel catch] wait, pending, canceled [000.009]: finished in 0.000 s [cancel catch] task, pending, canceled [000.009]: starting [cancel catch] task, pending, canceled [000.009]: finished in 0.000 s [cancel catch] task, pending, canceled, on_cancel, intercepted [000.009]: starting [cancel catch] task, pending, canceled, on_cancel, intercepted [000.009]: finished in 0.000 s [cancel catch] task, pending, canceled, on_cancel, forwarded [000.009]: starting [cancel catch] task, pending, canceled, on_cancel, forwarded [000.009]: finished in 0.000 s [cancel catch] pending, wait, canceled [000.009]: starting [cancel catch] pending, wait, canceled [000.009]: finished in 0.000 s [cancel catch] pending, task, canceled [000.009]: starting [cancel catch] pending, task, canceled [000.009]: finished in 0.000 s [cancel try_bind] wait, pending, canceled [000.010]: starting [cancel try_bind] wait, pending, canceled [000.010]: finished in 0.000 s [cancel try_bind] task, pending, canceled [000.010]: starting [cancel try_bind] task, pending, canceled [000.010]: finished in 0.000 s [cancel try_bind] pending, fulfilled, wait, canceled [000.010]: starting [cancel try_bind] pending, fulfilled, wait, canceled [000.010]: finished in 0.000 s [cancel try_bind] pending, fulfilled, task, canceled [000.010]: starting [cancel try_bind] pending, fulfilled, task, canceled [000.010]: finished in 0.000 s [cancel try_bind] pending, rejected, wait, canceled [000.010]: starting [cancel try_bind] pending, rejected, wait, canceled [000.010]: finished in 0.000 s [cancel try_bind] pending, rejected, task, canceled [000.010]: starting [cancel try_bind] pending, rejected, task, canceled [000.010]: finished in 0.000 s [cancel finalize] wait, pending, canceled [000.010]: starting [cancel finalize] wait, pending, canceled [000.010]: finished in 0.000 s [cancel finalize] task, pending, canceled [000.010]: starting [cancel finalize] task, pending, canceled [000.010]: finished in 0.000 s [cancel finalize] task, canceled, cancel exception replaced [000.010]: starting [cancel finalize] task, canceled, cancel exception replaced [000.010]: finished in 0.000 s [cancel finalize] pending, wait, canceled [000.010]: starting [cancel finalize] pending, wait, canceled [000.010]: finished in 0.000 s [cancel finalize] pending, task, canceled [000.010]: starting [cancel finalize] pending, task, canceled [000.010]: finished in 0.000 s [cancel with direct handler] on_success: pending, canceled [000.010]: starting [cancel with direct handler] on_success: pending, canceled [000.010]: finished in 0.000 s [cancel with direct handler] on_failure: pending, canceled [000.010]: starting [cancel with direct handler] on_failure: pending, canceled [000.010]: finished in 0.000 s [cancel with direct handler] on_termination: pending, canceled [000.010]: starting [cancel with direct handler] on_termination: pending, canceled [000.010]: finished in 0.000 s [cancel with direct handler] on_any: pending, canceled [000.010]: starting [cancel with direct handler] on_any: pending, canceled [000.010]: finished in 0.000 s [cancel join] wait, pending, cancel [000.010]: starting [cancel join] wait, pending, cancel [000.010]: finished in 0.000 s [cancel join] task, pending, cancel [000.010]: starting [cancel join] task, pending, cancel [000.010]: finished in 0.000 s [cancel join] wait and task, pending, cancel [000.010]: starting [cancel join] wait and task, pending, cancel [000.010]: finished in 0.000 s [cancel join] cancel diamond [000.010]: starting [cancel join] cancel diamond [000.010]: finished in 0.000 s [cancel choose] wait, pending, cancel [000.010]: starting [cancel choose] wait, pending, cancel [000.010]: finished in 0.000 s [cancel choose] wait and task, pending, cancel [000.010]: starting [cancel choose] wait and task, pending, cancel [000.010]: finished in 0.000 s [cancel pick] wait, pending, cancel [000.010]: starting [cancel pick] wait, pending, cancel [000.010]: finished in 0.000 s [cancel pick] wait and task, pending, cancel [000.010]: starting [cancel pick] wait and task, pending, cancel [000.010]: finished in 0.000 s [cancel nchoose] wait, pending, cancel [000.010]: starting [cancel nchoose] wait, pending, cancel [000.010]: finished in 0.000 s [cancel nchoose] wait and task, pending, cancel [000.010]: starting [cancel nchoose] wait and task, pending, cancel [000.010]: finished in 0.000 s [cancel npick] wait, pending, cancel [000.010]: starting [cancel npick] wait, pending, cancel [000.010]: finished in 0.000 s [cancel npick] wait and task, pending, cancel [000.010]: starting [cancel npick] wait and task, pending, cancel [000.010]: finished in 0.000 s [cancel nchoose_split] wait, pending, cancel [000.010]: starting [cancel nchoose_split] wait, pending, cancel [000.010]: finished in 0.000 s [cancel nchoose_split] wait and task, pending, cancel [000.010]: starting [cancel nchoose_split] wait and task, pending, cancel [000.010]: finished in 0.000 s [storage] initial [000.010]: starting [storage] initial [000.010]: finished in 0.000 s [storage] store, retrieve [000.010]: starting [storage] store, retrieve [000.010]: finished in 0.000 s [storage] store, restore [000.010]: starting [storage] store, restore [000.010]: finished in 0.000 s [storage] store, f raises, restore [000.010]: starting [storage] store, f raises, restore [000.010]: finished in 0.000 s [storage] store, overwrite, retrieve [000.010]: starting [storage] store, overwrite, retrieve [000.010]: finished in 0.000 s [storage] store, blank, retrieve [000.010]: starting [storage] store, blank, retrieve [000.010]: finished in 0.000 s [storage] distinct keys [000.010]: starting [storage] distinct keys [000.010]: finished in 0.000 s [storage] bind [000.010]: starting [storage] bind [000.010]: finished in 0.000 s [storage] map [000.010]: starting [storage] map [000.010]: finished in 0.000 s [storage] catch [000.010]: starting [storage] catch [000.010]: finished in 0.000 s [storage] try_bind, fulfilled [000.010]: starting [storage] try_bind, fulfilled [000.010]: finished in 0.000 s [storage] try_bind, rejected [000.010]: starting [storage] try_bind, rejected [000.010]: finished in 0.000 s [storage] finalize [000.010]: starting [storage] finalize [000.010]: finished in 0.000 s [storage] on_success [000.010]: starting [storage] on_success [000.010]: finished in 0.000 s [storage] on_failure [000.010]: starting [storage] on_failure [000.010]: finished in 0.000 s [storage] on_termination, fulfilled [000.010]: starting [storage] on_termination, fulfilled [000.010]: finished in 0.000 s [storage] on_termination, rejected [000.010]: starting [storage] on_termination, rejected [000.010]: finished in 0.000 s [storage] on_any, fulfilled [000.010]: starting [storage] on_any, fulfilled [000.010]: finished in 0.000 s [storage] on_any, rejected [000.010]: starting [storage] on_any, rejected [000.010]: finished in 0.000 s [storage] on_cancel [000.010]: starting [storage] on_cancel [000.011]: finished in 0.000 s [infix operators] >>= [000.011]: starting [infix operators] >>= [000.011]: finished in 0.000 s [infix operators] =<< [000.011]: starting [infix operators] =<< [000.011]: finished in 0.000 s [infix operators] >|= [000.011]: starting [infix operators] >|= [000.011]: finished in 0.000 s [infix operators] =|< [000.011]: starting [infix operators] =|< [000.011]: finished in 0.000 s [infix operators] <&> [000.011]: starting [infix operators] <&> [000.011]: finished in 0.000 s [infix operators] <?> [000.011]: starting [infix operators] <?> [000.011]: finished in 0.000 s [ppx_let] return [000.011]: starting [ppx_let] return [000.011]: finished in 0.000 s [ppx_let] map [000.011]: starting [ppx_let] map [000.011]: finished in 0.000 s [ppx_let] bind [000.011]: starting [ppx_let] bind [000.011]: finished in 0.000 s [ppx_let] both [000.011]: starting [ppx_let] both [000.011]: finished in 0.000 s [ppx_let] Open_on_rhs [000.011]: starting [ppx_let] Open_on_rhs [000.011]: finished in 0.000 s [let syntax] let* [000.011]: starting [let syntax] let* [000.011]: finished in 0.000 s [let syntax] and* [000.011]: starting [let syntax] and* [000.011]: finished in 0.000 s [let syntax] let+/and+ [000.011]: starting [let syntax] let+/and+ [000.011]: finished in 0.000 s [add_task_l and add_task_r] add_task_r [000.011]: starting [add_task_l and add_task_r] add_task_r [000.011]: finished in 0.000 s [add_task_l and add_task_r] add_task_l [000.011]: starting [add_task_l and add_task_r] add_task_l [000.011]: finished in 0.000 s [pause] initial state [000.011]: starting [pause] initial state [000.011]: finished in 0.000 s [pause] one promise [000.011]: starting [pause] one promise [000.011]: finished in 0.000 s [pause] multiple promises [000.011]: starting [pause] multiple promises [000.011]: finished in 0.000 s [pause] wakeup with no promises [000.011]: starting [pause] wakeup with no promises [000.011]: finished in 0.000 s [pause] pause notifier [000.011]: starting [pause] pause notifier [000.011]: finished in 0.000 s [pause] pause in unpause [000.011]: starting [pause] pause in unpause [000.011]: finished in 0.000 s [pause] recursive pause in notifier [000.011]: starting [pause] recursive pause in notifier [000.011]: finished in 0.000 s [pause] unpause in pause [000.011]: starting [pause] unpause in pause [000.011]: finished in 0.000 s [apply and wrap] apply [000.011]: starting [apply and wrap] apply [000.011]: finished in 0.000 s [apply and wrap] apply: raises [000.011]: starting [apply and wrap] apply: raises [000.011]: finished in 0.000 s [apply and wrap] wrap [000.011]: starting [apply and wrap] wrap [000.011]: finished in 0.000 s [apply and wrap] wrap: raises [000.011]: starting [apply and wrap] wrap: raises [000.011]: finished in 0.000 s [apply and wrap] wrap1 [000.011]: starting [apply and wrap] wrap1 [000.011]: finished in 0.000 s [apply and wrap] wrap1: raises [000.011]: starting [apply and wrap] wrap1: raises [000.011]: finished in 0.000 s [apply and wrap] wrap2 [000.011]: starting [apply and wrap] wrap2 [000.011]: finished in 0.000 s [apply and wrap] wrap2: raises [000.011]: starting [apply and wrap] wrap2: raises [000.011]: finished in 0.000 s [apply and wrap] wrap3 [000.011]: starting [apply and wrap] wrap3 [000.011]: finished in 0.000 s [apply and wrap] wrap3: raises [000.011]: starting [apply and wrap] wrap3: raises [000.011]: finished in 0.000 s [apply and wrap] wrap4 [000.011]: starting [apply and wrap] wrap4 [000.011]: finished in 0.000 s [apply and wrap] wrap4: raises [000.011]: starting [apply and wrap] wrap4: raises [000.011]: finished in 0.000 s [apply and wrap] wrap5 [000.011]: starting [apply and wrap] wrap5 [000.011]: finished in 0.000 s [apply and wrap] wrap5: raises [000.011]: starting [apply and wrap] wrap5: raises [000.011]: finished in 0.000 s [apply and wrap] wrap6 [000.011]: starting [apply and wrap] wrap6 [000.011]: finished in 0.000 s [apply and wrap] wrap6: raises [000.011]: starting [apply and wrap] wrap6: raises [000.011]: finished in 0.000 s [apply and wrap] wrap7 [000.011]: starting [apply and wrap] wrap7 [000.011]: finished in 0.000 s [apply and wrap] wrap7: raises [000.012]: starting [apply and wrap] wrap7: raises [000.012]: finished in 0.000 s [callback cleanup] choose [000.012]: starting [callback cleanup] choose [000.012]: finished in 0.000 s [callback cleanup] bind [000.012]: starting [callback cleanup] bind [000.012]: finished in 0.000 s [tailrec] tailrec [000.012]: starting [tailrec] tailrec [000.297]: finished in 0.285 s [lwt_stream] from [000.297]: starting [lwt_stream] from [000.297]: finished in 0.000 s [lwt_stream] return [000.297]: starting [lwt_stream] return [000.297]: finished in 0.000 s [lwt_stream] return_lwt [000.297]: starting [lwt_stream] return_lwt [000.297]: finished in 0.000 s [lwt_stream] return_lwt_with_pause [000.297]: starting [lwt_stream] return_lwt_with_pause [000.297]: finished in 0.000 s [lwt_stream] return_lwt_with_fail [000.297]: starting [lwt_stream] return_lwt_with_fail [000.297]: finished in 0.000 s [lwt_stream] of_seq [000.297]: starting [lwt_stream] of_seq [000.297]: finished in 0.000 s [lwt_stream] of_lwt_seq [000.297]: starting [lwt_stream] of_lwt_seq [000.297]: finished in 0.000 s [lwt_stream] of_list [000.297]: starting [lwt_stream] of_list [000.297]: finished in 0.000 s [lwt_stream] clone [000.297]: starting [lwt_stream] clone [000.297]: finished in 0.000 s [lwt_stream] clone 2 [000.297]: starting [lwt_stream] clone 2 [000.297]: finished in 0.000 s [lwt_stream] create [000.297]: starting [lwt_stream] create [000.297]: finished in 0.000 s [lwt_stream] create 2 [000.297]: starting [lwt_stream] create 2 [000.297]: finished in 0.000 s [lwt_stream] create_bounded [000.297]: starting [lwt_stream] create_bounded [000.297]: finished in 0.000 s [lwt_stream] create_bounded close [000.297]: starting [lwt_stream] create_bounded close [000.297]: finished in 0.000 s [lwt_stream] get_while [000.297]: starting [lwt_stream] get_while [000.297]: finished in 0.000 s [lwt_stream] peek [000.297]: starting [lwt_stream] peek [000.297]: finished in 0.000 s [lwt_stream] npeek [000.297]: starting [lwt_stream] npeek [000.297]: finished in 0.000 s [lwt_stream] get_available [000.297]: starting [lwt_stream] get_available [000.297]: finished in 0.000 s [lwt_stream] get_available_up_to [000.297]: starting [lwt_stream] get_available_up_to [000.297]: finished in 0.000 s [lwt_stream] filter [000.297]: starting [lwt_stream] filter [000.297]: finished in 0.000 s [lwt_stream] filter_map [000.297]: starting [lwt_stream] filter_map [000.297]: finished in 0.000 s [lwt_stream] last_new [000.297]: starting [lwt_stream] last_new [000.297]: finished in 0.000 s [lwt_stream] junk_available [000.297]: starting [lwt_stream] junk_available [000.297]: finished in 0.000 s [lwt_stream] junk_old [000.297]: starting [lwt_stream] junk_old [000.297]: finished in 0.000 s [lwt_stream] cancel push stream 1 [000.297]: starting [lwt_stream] cancel push stream 1 [000.297]: finished in 0.000 s [lwt_stream] cancel push stream 2 [000.297]: starting [lwt_stream] cancel push stream 2 [000.297]: finished in 0.000 s [lwt_stream] cancel push stream 3 [000.297]: starting [lwt_stream] cancel push stream 3 [000.297]: finished in 0.000 s [lwt_stream] push and GC [000.297]: starting [lwt_stream] push and GC [000.298]: finished in 0.001 s [lwt_stream] map_exn [000.298]: starting [lwt_stream] map_exn [000.298]: finished in 0.000 s [lwt_stream] is_closed [000.298]: starting [lwt_stream] is_closed [000.298]: finished in 0.000 s [lwt_stream] closed(bind) [000.298]: starting [lwt_stream] closed(bind) [000.298]: finished in 0.000 s [lwt_stream] closed(on_termination) [000.298]: starting [lwt_stream] closed(on_termination) [000.298]: finished in 0.000 s [lwt_stream] closed when closed [000.298]: starting [lwt_stream] closed when closed [000.298]: finished in 0.000 s [lwt_stream] choose_exhausted [000.298]: starting [lwt_stream] choose_exhausted [000.298]: finished in 0.000 s [lwt_stream] exception passing: basic, from [000.298]: starting [lwt_stream] exception passing: basic, from [000.298]: finished in 0.000 s [lwt_stream] exception passing: basic, from_direct [000.298]: starting [lwt_stream] exception passing: basic, from_direct [000.298]: finished in 0.000 s [lwt_stream] exception passing: to_list [000.298]: starting [lwt_stream] exception passing: to_list [000.298]: finished in 0.000 s [lwt_stream] exception passing: mapped [000.298]: starting [lwt_stream] exception passing: mapped [000.298]: finished in 0.000 s [lwt_stream] exception passing: resume, not closed, from [000.298]: starting [lwt_stream] exception passing: resume, not closed, from [000.298]: finished in 0.000 s [lwt_stream] exception passing: resume, not closed, from_direct [000.298]: starting [lwt_stream] exception passing: resume, not closed, from_direct [000.298]: finished in 0.000 s [lwt_list] iter_p [000.298]: starting [lwt_list] iter_p [000.298]: finished in 0.000 s [lwt_list] iter_s [000.298]: starting [lwt_list] iter_s [000.298]: finished in 0.000 s [lwt_list] map_p [000.298]: starting [lwt_list] map_p [000.298]: finished in 0.000 s [lwt_list] map_s [000.298]: starting [lwt_list] map_s [000.298]: finished in 0.000 s [lwt_list] fold_left_s [000.298]: starting [lwt_list] fold_left_s [000.298]: finished in 0.000 s [lwt_list] for_all_s [000.298]: starting [lwt_list] for_all_s [000.298]: finished in 0.000 s [lwt_list] for_all_p [000.298]: starting [lwt_list] for_all_p [000.298]: finished in 0.000 s [lwt_list] exists_s true [000.298]: starting [lwt_list] exists_s true [000.298]: finished in 0.000 s [lwt_list] exists_p true [000.298]: starting [lwt_list] exists_p true [000.298]: finished in 0.000 s [lwt_list] exists_s false [000.298]: starting [lwt_list] exists_s false [000.298]: finished in 0.000 s [lwt_list] exists_p false [000.298]: starting [lwt_list] exists_p false [000.298]: finished in 0.000 s [lwt_list] filter_s [000.298]: starting [lwt_list] filter_s [000.298]: finished in 0.000 s [lwt_list] filter_p [000.298]: starting [lwt_list] filter_p [000.298]: finished in 0.000 s [lwt_list] partition_p [000.298]: starting [lwt_list] partition_p [000.299]: finished in 0.000 s [lwt_list] partition_s [000.299]: starting [lwt_list] partition_s [000.299]: finished in 0.000 s [lwt_list] filter_map_p [000.299]: starting [lwt_list] filter_map_p [000.299]: finished in 0.000 s [lwt_list] filter_map_s [000.299]: starting [lwt_list] filter_map_s [000.299]: finished in 0.000 s [lwt_list] iteri_p [000.299]: starting [lwt_list] iteri_p [000.299]: finished in 0.000 s [lwt_list] iteri_s [000.299]: starting [lwt_list] iteri_s [000.299]: finished in 0.000 s [lwt_list] mapi_p [000.299]: starting [lwt_list] mapi_p [000.299]: finished in 0.000 s [lwt_list] mapi_s [000.299]: starting [lwt_list] mapi_s [000.299]: finished in 0.000 s [lwt_list] find_s existing [000.299]: starting [lwt_list] find_s existing [000.299]: finished in 0.000 s [lwt_list] find_s missing [000.299]: starting [lwt_list] find_s missing [000.299]: finished in 0.000 s [lwt_list] rev_map_p [000.299]: starting [lwt_list] rev_map_p [000.299]: finished in 0.000 s [lwt_list] rev_map_s [000.299]: starting [lwt_list] rev_map_s [000.299]: finished in 0.000 s [lwt_list] fold_right_s [000.299]: starting [lwt_list] fold_right_s [000.299]: finished in 0.000 s [lwt_list] iteri_p exception [000.299]: starting [lwt_list] iteri_p exception [000.299]: finished in 0.000 s [lwt_list] iteri_s exception [000.299]: starting [lwt_list] iteri_s exception [000.299]: finished in 0.000 s [lwt_list] map_s exception [000.299]: starting [lwt_list] map_s exception [000.299]: finished in 0.000 s [lwt_list] map_p exception [000.299]: starting [lwt_list] map_p exception [000.299]: finished in 0.000 s [lwt_list] mapi_s exception [000.299]: starting [lwt_list] mapi_s exception [000.299]: finished in 0.000 s [lwt_list] mapi_p exception [000.299]: starting [lwt_list] mapi_p exception [000.299]: finished in 0.000 s [lwt_list] rev_map_s exception [000.299]: starting [lwt_list] rev_map_s exception [000.299]: finished in 0.000 s [lwt_list] rev_map_p exception [000.299]: starting [lwt_list] rev_map_p exception [000.299]: finished in 0.000 s [lwt_list] fold_left_s exception [000.299]: starting [lwt_list] fold_left_s exception [000.299]: finished in 0.000 s [lwt_list] fold_right_s exception [000.299]: starting [lwt_list] fold_right_s exception [000.299]: finished in 0.000 s [lwt_list] for_all_p exception [000.299]: starting [lwt_list] for_all_p exception [000.299]: finished in 0.000 s [lwt_list] for_all_s exception [000.299]: starting [lwt_list] for_all_s exception [000.299]: finished in 0.000 s [lwt_list] exists_p exception [000.299]: starting [lwt_list] exists_p exception [000.299]: finished in 0.000 s [lwt_list] exists_s exception [000.299]: starting [lwt_list] exists_s exception [000.299]: finished in 0.000 s [lwt_list] find_s exception [000.299]: starting [lwt_list] find_s exception [000.299]: finished in 0.000 s [lwt_list] filter_p exception [000.299]: starting [lwt_list] filter_p exception [000.299]: finished in 0.000 s [lwt_list] filter_s exception [000.299]: starting [lwt_list] filter_s exception [000.299]: finished in 0.000 s [lwt_list] filter_map_p exception [000.299]: starting [lwt_list] filter_map_p exception [000.299]: finished in 0.000 s [lwt_list] filter_map_s exception [000.299]: starting [lwt_list] filter_map_s exception [000.299]: finished in 0.000 s [lwt_list] partition_p exception [000.299]: starting [lwt_list] partition_p exception [000.299]: finished in 0.000 s [lwt_list] partition_s exception [000.299]: starting [lwt_list] partition_s exception [000.299]: finished in 0.000 s [lwt_list] iter_p parallelism [000.299]: starting [lwt_list] iter_p parallelism [000.299]: finished in 0.000 s [lwt_list] iter_s serialization [000.299]: starting [lwt_list] iter_s serialization [000.299]: finished in 0.000 s [lwt_list] iteri_p parallelism [000.299]: starting [lwt_list] iteri_p parallelism [000.299]: finished in 0.000 s [lwt_list] iteri_s serialization [000.299]: starting [lwt_list] iteri_s serialization [000.299]: finished in 0.000 s [lwt_list] map_p parallelism [000.299]: starting [lwt_list] map_p parallelism [000.299]: finished in 0.000 s [lwt_list] map_s serialization [000.299]: starting [lwt_list] map_s serialization [000.299]: finished in 0.000 s [lwt_list] mapi_p parallelism [000.299]: starting [lwt_list] mapi_p parallelism [000.299]: finished in 0.000 s [lwt_list] mapi_s serialization [000.299]: starting [lwt_list] mapi_s serialization [000.299]: finished in 0.000 s [lwt_list] rev_map_p parallelism [000.299]: starting [lwt_list] rev_map_p parallelism [000.299]: finished in 0.000 s [lwt_list] rev_map_s serialization [000.299]: starting [lwt_list] rev_map_s serialization [000.299]: finished in 0.000 s [lwt_list] fold_left_s serialization [000.299]: starting [lwt_list] fold_left_s serialization [000.299]: finished in 0.000 s [lwt_list] fold_right_s serialization [000.299]: starting [lwt_list] fold_right_s serialization [000.299]: finished in 0.000 s [lwt_list] filter_map_p parallelism [000.299]: starting [lwt_list] filter_map_p parallelism [000.299]: finished in 0.000 s [lwt_list] filter_map_s serlialism [000.299]: starting [lwt_list] filter_map_s serlialism [000.299]: finished in 0.000 s [lwt_list] for_all_p parallelism [000.299]: starting [lwt_list] for_all_p parallelism [000.299]: finished in 0.000 s [lwt_list] for_all_s serialization [000.299]: starting [lwt_list] for_all_s serialization [000.299]: finished in 0.000 s [lwt_list] exists_p parallelism [000.299]: starting [lwt_list] exists_p parallelism [000.299]: finished in 0.000 s [lwt_list] exists_s serialization [000.299]: starting [lwt_list] exists_s serialization [000.299]: finished in 0.000 s [lwt_list] find_s serialization [000.299]: starting [lwt_list] find_s serialization [000.299]: finished in 0.000 s [lwt_list] filter_p parallelism [000.299]: starting [lwt_list] filter_p parallelism [000.299]: finished in 0.000 s [lwt_list] filter_s serialization [000.299]: starting [lwt_list] filter_s serialization [000.299]: finished in 0.000 s [lwt_list] filter_map_s serialization [000.299]: starting [lwt_list] filter_map_s serialization [000.299]: finished in 0.000 s [lwt_list] partition_p parallelism [000.299]: starting [lwt_list] partition_p parallelism [000.299]: finished in 0.000 s [lwt_list] partition_s serialization [000.299]: starting [lwt_list] partition_s serialization [000.299]: finished in 0.000 s lwt_list big lists [000.299]: skipping [lwt_switch] turn_off, add_hook [000.299]: starting [lwt_switch] turn_off, add_hook [000.299]: finished in 0.000 s [lwt_switch] turn_off: hook exception [000.299]: starting [lwt_switch] turn_off: hook exception [000.299]: finished in 0.000 s [lwt_switch] with_switch: regular exit [000.299]: starting [lwt_switch] with_switch: regular exit [000.299]: finished in 0.000 s [lwt_switch] with_switch: exception [000.299]: starting [lwt_switch] with_switch: exception [000.299]: finished in 0.000 s [lwt_switch] check [000.299]: starting [lwt_switch] check [000.299]: finished in 0.000 s [lwt_switch] is_on [000.299]: starting [lwt_switch] is_on [000.299]: finished in 0.000 s [lwt_switch] add_hook_or_exec [000.299]: starting [lwt_switch] add_hook_or_exec [000.299]: finished in 0.000 s [lwt_switch] turn_off waits for hooks: regular exit [000.299]: starting [lwt_switch] turn_off waits for hooks: regular exit [000.299]: finished in 0.000 s [lwt_switch] turn_off waits for hooks: hook exception [000.299]: starting [lwt_switch] turn_off waits for hooks: hook exception [000.299]: finished in 0.000 s [lwt_mutex] cancel [000.299]: starting [lwt_mutex] cancel [000.299]: finished in 0.000 s [lwt_mutex] cancel while queued by unlock [000.299]: starting [lwt_mutex] cancel while queued by unlock [000.299]: finished in 0.000 s [lwt_result] maps [000.299]: starting [lwt_result] maps [000.299]: finished in 0.000 s [lwt_result] >|= is a variant of map [000.299]: starting [lwt_result] >|= is a variant of map [000.299]: finished in 0.000 s [lwt_result] map, error case [000.299]: starting [lwt_result] map, error case [000.299]: finished in 0.000 s [lwt_result] map_error [000.299]: starting [lwt_result] map_error [000.299]: finished in 0.000 s [lwt_result] map_error, error case [000.299]: starting [lwt_result] map_error, error case [000.299]: finished in 0.000 s [lwt_result] bind [000.299]: starting [lwt_result] bind [000.299]: finished in 0.000 s [lwt_result] bind, error case [000.299]: starting [lwt_result] bind, error case [000.300]: finished in 0.000 s [lwt_result] bind_error [000.300]: starting [lwt_result] bind_error [000.300]: finished in 0.000 s [lwt_result] bind_error, error case [000.300]: starting [lwt_result] bind_error, error case [000.300]: finished in 0.000 s [lwt_result] ok [000.300]: starting [lwt_result] ok [000.300]: finished in 0.000 s [lwt_result] error [000.300]: starting [lwt_result] error [000.300]: finished in 0.000 s [lwt_result] catch [000.300]: starting [lwt_result] catch [000.300]: finished in 0.000 s [lwt_result] catch, error case [000.300]: starting [lwt_result] catch, error case [000.300]: finished in 0.000 s [lwt_result] catch, bound raise [000.300]: starting [lwt_result] catch, bound raise [000.300]: finished in 0.000 s [lwt_result] catch, immediate raise [000.300]: starting [lwt_result] catch, immediate raise [000.300]: finished in 0.000 s [lwt_result] get_exn [000.300]: starting [lwt_result] get_exn [000.300]: finished in 0.000 s [lwt_result] get_exn, error case [000.300]: starting [lwt_result] get_exn, error case [000.300]: finished in 0.000 s [lwt_result] bind_lwt [000.300]: starting [lwt_result] bind_lwt [000.300]: finished in 0.000 s [lwt_result] bind_lwt, error case [000.300]: starting [lwt_result] bind_lwt, error case [000.300]: finished in 0.000 s [lwt_result] bind_lwt_error [000.300]: starting [lwt_result] bind_lwt_error [000.300]: finished in 0.000 s [lwt_result] bind_lwt_error, error case [000.300]: starting [lwt_result] bind_lwt_error, error case [000.300]: finished in 0.000 s [lwt_result] bind_result [000.300]: starting [lwt_result] bind_result [000.300]: finished in 0.000 s [lwt_result] bind_result, error case [000.300]: starting [lwt_result] bind_result, error case [000.300]: finished in 0.000 s [lwt_result] both ok [000.300]: starting [lwt_result] both ok [000.300]: finished in 0.000 s [lwt_result] both only fst error [000.300]: starting [lwt_result] both only fst error [000.300]: finished in 0.000 s [lwt_result] both only snd error [000.300]: starting [lwt_result] both only snd error [000.300]: finished in 0.000 s [lwt_result] both error, fst [000.300]: starting [lwt_result] both error, fst [000.300]: finished in 0.000 s [lwt_result] both error, snd [000.300]: starting [lwt_result] both error, snd [000.300]: finished in 0.000 s [lwt_result] iter [000.300]: starting [lwt_result] iter [000.300]: finished in 0.000 s [lwt_result] iter, error case [000.300]: starting [lwt_result] iter, error case [000.300]: finished in 0.000 s [lwt_result] iter_error [000.300]: starting [lwt_result] iter_error [000.300]: finished in 0.000 s [lwt_result] iter_error, success case [000.300]: starting [lwt_result] iter_error, success case [000.300]: finished in 0.000 s [lwt_result] let* [000.300]: starting [lwt_result] let* [000.300]: finished in 0.000 s [lwt_result] and* [000.300]: starting [lwt_result] and* [000.300]: finished in 0.000 s [lwt_result] let+/and+ [000.300]: starting [lwt_result] let+/and+ [000.300]: finished in 0.000 s [lwt_mvar] basic take [000.300]: starting [lwt_mvar] basic take [000.300]: finished in 0.000 s [lwt_mvar] take_available (full) [000.300]: starting [lwt_mvar] take_available (full) [000.300]: finished in 0.000 s [lwt_mvar] take_available (empty) [000.300]: starting [lwt_mvar] take_available (empty) [000.300]: finished in 0.000 s [lwt_mvar] take_available (twice) [000.300]: starting [lwt_mvar] take_available (twice) [000.300]: finished in 0.000 s [lwt_mvar] is_empty (full) [000.300]: starting [lwt_mvar] is_empty (full) [000.300]: finished in 0.000 s [lwt_mvar] is_empty (empty) [000.300]: starting [lwt_mvar] is_empty (empty) [000.300]: finished in 0.000 s [lwt_mvar] blocking put [000.300]: starting [lwt_mvar] blocking put [000.300]: finished in 0.000 s [lwt_mvar] put-take [000.300]: starting [lwt_mvar] put-take [000.300]: finished in 0.000 s [lwt_mvar] take-put [000.300]: starting [lwt_mvar] take-put [000.300]: finished in 0.000 s [lwt_mvar] enqueued writer [000.300]: starting [lwt_mvar] enqueued writer [000.300]: finished in 0.000 s [lwt_mvar] writer cancellation [000.300]: starting [lwt_mvar] writer cancellation [000.300]: finished in 0.000 s [lwt_condition] basic wait [000.300]: starting [lwt_condition] basic wait [000.300]: finished in 0.000 s [lwt_condition] mutex unlocked during wait [000.300]: starting [lwt_condition] mutex unlocked during wait [000.300]: finished in 0.000 s [lwt_condition] mutex relocked after wait [000.300]: starting [lwt_condition] mutex relocked after wait [000.300]: finished in 0.000 s [lwt_condition] signal is not sticky [000.300]: starting [lwt_condition] signal is not sticky [000.300]: finished in 0.000 s [lwt_condition] broadcast [000.300]: starting [lwt_condition] broadcast [000.300]: finished in 0.000 s [lwt_condition] broadcast exception [000.300]: starting [lwt_condition] broadcast exception [000.300]: finished in 0.000 s [lwt_pool] basic create-use [000.300]: starting [lwt_pool] basic create-use [000.300]: finished in 0.000 s [lwt_pool] creator exception [000.300]: starting [lwt_pool] creator exception [000.300]: finished in 0.000 s [lwt_pool] pool elements are reused [000.300]: starting [lwt_pool] pool elements are reused [000.300]: finished in 0.000 s [lwt_pool] pool elements are validated when returned [000.300]: starting [lwt_pool] pool elements are validated when returned [000.300]: finished in 0.000 s [lwt_pool] validation exceptions are propagated to users [000.300]: starting [lwt_pool] validation exceptions are propagated to users [000.300]: finished in 0.000 s [lwt_pool] multiple creation [000.300]: starting [lwt_pool] multiple creation [000.300]: finished in 0.000 s [lwt_pool] users of an empty pool will wait [000.300]: starting [lwt_pool] users of an empty pool will wait [000.300]: finished in 0.000 s [lwt_pool] on check, good elements are retained [000.300]: starting [lwt_pool] on check, good elements are retained [000.300]: finished in 0.000 s [lwt_pool] on check, bad elements are disposed of and replaced [000.300]: starting [lwt_pool] on check, bad elements are disposed of and replaced [000.300]: finished in 0.000 s [lwt_pool] clear disposes of all elements [000.300]: starting [lwt_pool] clear disposes of all elements [000.300]: finished in 0.000 s [lwt_pool] waiter are notified on replacement [000.300]: starting [lwt_pool] waiter are notified on replacement [000.300]: finished in 0.000 s [lwt_pool] waiter are notified on replacement exception [000.300]: starting [lwt_pool] waiter are notified on replacement exception [000.300]: finished in 0.000 s [lwt_pool] check and validate can be used together [000.300]: starting [lwt_pool] check and validate can be used together [000.300]: finished in 0.000 s [lwt_pool] verify default check behavior [000.300]: starting [lwt_pool] verify default check behavior [000.300]: finished in 0.000 s [lwt_sequence] create [000.300]: starting [lwt_sequence] create [000.300]: finished in 0.000 s [lwt_sequence] add_l [000.300]: starting [lwt_sequence] add_l [000.300]: finished in 0.000 s [lwt_sequence] add_r [000.300]: starting [lwt_sequence] add_r [000.300]: finished in 0.000 s [lwt_sequence] take_l Empty [000.300]: starting [lwt_sequence] take_l Empty [000.300]: finished in 0.000 s [lwt_sequence] take_l [000.300]: starting [lwt_sequence] take_l [000.300]: finished in 0.000 s [lwt_sequence] take_r Empty [000.300]: starting [lwt_sequence] take_r Empty [000.300]: finished in 0.000 s [lwt_sequence] take_r [000.300]: starting [lwt_sequence] take_r [000.300]: finished in 0.000 s [lwt_sequence] take_opt_l Empty [000.300]: starting [lwt_sequence] take_opt_l Empty [000.300]: finished in 0.000 s [lwt_sequence] take_opt_l [000.300]: starting [lwt_sequence] take_opt_l [000.300]: finished in 0.000 s [lwt_sequence] take_opt_r Empty [000.300]: starting [lwt_sequence] take_opt_r Empty [000.300]: finished in 0.000 s [lwt_sequence] take_opt_r [000.300]: starting [lwt_sequence] take_opt_r [000.300]: finished in 0.000 s [lwt_sequence] transfer_l Empty [000.300]: starting [lwt_sequence] transfer_l Empty [000.300]: finished in 0.000 s [lwt_sequence] transfer_l [000.300]: starting [lwt_sequence] transfer_l [000.300]: finished in 0.000 s [lwt_sequence] transfer_r Empty [000.300]: starting [lwt_sequence] transfer_r Empty [000.300]: finished in 0.000 s [lwt_sequence] transfer_r [000.300]: starting [lwt_sequence] transfer_r [000.300]: finished in 0.000 s [lwt_sequence] iter_l Empty [000.300]: starting [lwt_sequence] iter_l Empty [000.300]: finished in 0.000 s [lwt_sequence] iter_l [000.300]: starting [lwt_sequence] iter_l [000.300]: finished in 0.000 s [lwt_sequence] iter_r Empty [000.300]: starting [lwt_sequence] iter_r Empty [000.300]: finished in 0.000 s [lwt_sequence] iter_r [000.300]: starting [lwt_sequence] iter_r [000.300]: finished in 0.000 s [lwt_sequence] iter_node_l Empty [000.301]: starting [lwt_sequence] iter_node_l Empty [000.301]: finished in 0.000 s [lwt_sequence] iter_node_l [000.301]: starting [lwt_sequence] iter_node_l [000.301]: finished in 0.000 s [lwt_sequence] iter_node_r Empty [000.301]: starting [lwt_sequence] iter_node_r Empty [000.301]: finished in 0.000 s [lwt_sequence] iter_node_r [000.301]: starting [lwt_sequence] iter_node_r [000.301]: finished in 0.000 s [lwt_sequence] iter_node_l with removal [000.301]: starting [lwt_sequence] iter_node_l with removal [000.301]: finished in 0.000 s [lwt_sequence] iter_node_r with removal [000.301]: starting [lwt_sequence] iter_node_r with removal [000.301]: finished in 0.000 s [lwt_sequence] fold_l [000.301]: starting [lwt_sequence] fold_l [000.301]: finished in 0.000 s [lwt_sequence] fold_l Empty [000.301]: starting [lwt_sequence] fold_l Empty [000.301]: finished in 0.000 s [lwt_sequence] fold_r [000.301]: starting [lwt_sequence] fold_r [000.301]: finished in 0.000 s [lwt_sequence] fold_r Empty [000.301]: starting [lwt_sequence] fold_r Empty [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_l Empty [000.301]: starting [lwt_sequence] find_node_opt_l Empty [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_l not found [000.301]: starting [lwt_sequence] find_node_opt_l not found [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_l [000.301]: starting [lwt_sequence] find_node_opt_l [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_r Empty [000.301]: starting [lwt_sequence] find_node_opt_r Empty [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_r not found [000.301]: starting [lwt_sequence] find_node_opt_r not found [000.301]: finished in 0.000 s [lwt_sequence] find_node_opt_r [000.301]: starting [lwt_sequence] find_node_opt_r [000.301]: finished in 0.000 s [lwt_sequence] find_node_l Empty [000.301]: starting [lwt_sequence] find_node_l Empty [000.301]: finished in 0.000 s [lwt_sequence] find_node_l [000.301]: starting [lwt_sequence] find_node_l [000.301]: finished in 0.000 s [lwt_sequence] find_node_r Empty [000.301]: starting [lwt_sequence] find_node_r Empty [000.301]: finished in 0.000 s [lwt_sequence] find_node_r [000.301]: starting [lwt_sequence] find_node_r [000.301]: finished in 0.000 s [lwt_sequence] set [000.301]: starting [lwt_sequence] set [000.301]: finished in 0.000 s [lwt_sequence] fold_r with multiple removal [000.301]: starting [lwt_sequence] fold_r with multiple removal [000.301]: finished in 0.000 s [lwt_sequence] fold_l multiple removal [000.301]: starting [lwt_sequence] fold_l multiple removal [000.301]: finished in 0.000 s [lwt_sequence] find_node_r with multiple removal [000.301]: starting [lwt_sequence] find_node_r with multiple removal [000.301]: finished in 0.000 s [lwt_sequence] find_node_l with multiple removal [000.301]: starting [lwt_sequence] find_node_l with multiple removal [000.301]: finished in 0.000 s [lwt_seq] fold_left [000.301]: starting [lwt_seq] fold_left [000.301]: finished in 0.000 s [lwt_seq] fold_left_s [000.301]: starting [lwt_seq] fold_left_s [000.301]: finished in 0.000 s [lwt_seq] map [000.301]: starting [lwt_seq] map [000.301]: finished in 0.000 s [lwt_seq] map_s [000.301]: starting [lwt_seq] map_s [000.301]: finished in 0.000 s [lwt_seq] filter [000.301]: starting [lwt_seq] filter [000.301]: finished in 0.000 s [lwt_seq] filter_s [000.301]: starting [lwt_seq] filter_s [000.301]: finished in 0.000 s [lwt_seq] iter_n(1) [000.301]: starting [lwt_seq] iter_n(1) [000.301]: finished in 0.000 s [lwt_seq] iter_n(2) [000.301]: starting [lwt_seq] iter_n(2) [000.301]: finished in 0.000 s [lwt_seq] iter_n(100) [000.301]: starting [lwt_seq] iter_n(100) [000.301]: finished in 0.000 s [lwt_seq] filter_map [000.301]: starting [lwt_seq] filter_map [000.301]: finished in 0.000 s [lwt_seq] filter_map_s [000.301]: starting [lwt_seq] filter_map_s [000.301]: finished in 0.000 s [lwt_seq] unfold [000.301]: starting [lwt_seq] unfold [000.301]: finished in 0.000 s [lwt_seq] unfold_lwt [000.301]: starting [lwt_seq] unfold_lwt [000.301]: finished in 0.000 s [lwt_seq] fold-into-exception-from-of-seq [000.301]: starting [lwt_seq] fold-into-exception-from-of-seq [000.301]: finished in 0.000 s [lwt_seq] fold-into-immediate-exception-from-of-seq [000.301]: starting [lwt_seq] fold-into-immediate-exception-from-of-seq [000.301]: finished in 0.000 s [lwt_seq] fold-into-exception-from-of-seq-lwt [000.301]: starting [lwt_seq] fold-into-exception-from-of-seq-lwt [000.301]: finished in 0.000 s [lwt_seq] fold-into-immediate-exception-from-of-seq-lwt [000.301]: starting [lwt_seq] fold-into-immediate-exception-from-of-seq-lwt [000.301]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] map [000.301]: starting [lwt_seq(pseudo-fuzzing)] map [000.302]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] map_s [000.302]: starting [lwt_seq(pseudo-fuzzing)] map_s [000.302]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] iter [000.302]: starting [lwt_seq(pseudo-fuzzing)] iter [000.302]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] iter_s [000.302]: starting [lwt_seq(pseudo-fuzzing)] iter_s [000.302]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] iter_p [000.302]: starting [lwt_seq(pseudo-fuzzing)] iter_p [000.302]: finished in 0.000 s [lwt_seq(pseudo-fuzzing)] iter_p (pause) [000.302]: starting [lwt_seq(pseudo-fuzzing)] iter_p (pause) [000.305]: finished in 0.003 s [lwt_seq(pseudo-fuzzing)] iter_n [000.305]: starting [lwt_seq(pseudo-fuzzing)] iter_n [000.307]: finished in 0.001 s [lwt_seq(pseudo-fuzzing)] iter_n (pause) [000.307]: starting [lwt_seq(pseudo-fuzzing)] iter_n (pause) [000.331]: finished in 0.024 s (cd _build/default/test/ppx && ./main.exe) Testing library 'ppx'... ................ Ok. 16 tests ran, 0 tests skipped in 1.20 seconds [ppx] let [000.000]: starting [ppx] let [000.000]: finished in 0.000 s [ppx] nested let [000.000]: starting [ppx] nested let [000.000]: finished in 0.000 s [ppx] and let [000.000]: starting [ppx] and let [000.000]: finished in 0.000 s [ppx] match [000.000]: starting [ppx] match [000.000]: finished in 0.000 s [ppx] match-exn [000.000]: starting [ppx] match-exn [000.000]: finished in 0.000 s [ppx] if [000.000]: starting [ppx] if [000.000]: finished in 0.000 s [ppx] for [000.000]: starting [ppx] for [000.601]: finished in 0.601 s [ppx] while [000.601]: starting [ppx] while [001.203]: finished in 0.602 s [ppx] assert [001.203]: starting [ppx] assert [001.203]: finished in 0.000 s [ppx] try [001.203]: starting [ppx] try [001.203]: finished in 0.000 s [ppx] try raise [001.203]: starting [ppx] try raise [001.203]: finished in 0.000 s [ppx] try fallback [001.203]: starting [ppx] try fallback [001.203]: finished in 0.000 s [ppx] finally body [001.203]: starting [ppx] finally body [001.203]: finished in 0.000 s [ppx] finally exn [001.203]: starting [ppx] finally exn [001.203]: finished in 0.000 s [ppx] finally exn default [001.203]: starting [ppx] finally exn default [001.203]: finished in 0.000 s [ppx] structure let [001.203]: starting [ppx] structure let [001.203]: finished in 0.000 s (cd _build/default/test/react && ./main.exe) Testing library 'react'... ........... Ok. 11 tests ran, 0 tests skipped in 4.50 seconds [lwt_event] to_stream [000.000]: starting [lwt_event] to_stream [000.000]: finished in 0.000 s [lwt_event] to_stream 2 [000.000]: starting [lwt_event] to_stream 2 [000.000]: finished in 0.000 s [lwt_event] map_s [000.000]: starting [lwt_event] map_s [000.000]: finished in 0.000 s [lwt_event] map_p [000.000]: starting [lwt_event] map_p [000.000]: finished in 0.000 s [lwt_event] limit_race [000.000]: starting [lwt_event] limit_race [002.501]: finished in 2.501 s [lwt_event] of_stream [002.501]: starting [lwt_event] of_stream [002.501]: finished in 0.000 s [lwt_event] limit [002.501]: starting [lwt_event] limit [002.502]: finished in 0.000 s [lwt_event] with_finaliser lifetime [002.502]: starting [lwt_event] with_finaliser lifetime [002.503]: finished in 0.002 s [lwt_signal] limit [002.503]: starting [lwt_signal] limit [002.503]: finished in 0.000 s [lwt_signal] limit race condition [002.503]: starting [lwt_signal] limit race condition [004.504]: finished in 2.001 s [lwt_signal] with_finaliser lifetime [004.504]: starting [lwt_signal] with_finaliser lifetime [004.505]: finished in 0.001 s (cd _build/default/test/unix && ./main.exe) Testing library 'unix'... .................................S.S....SSS.............................................................................................................SSSS............................................................................. Ok. 224 tests ran, 9 tests skipped in 6.34 seconds [lwt_unix] wait [000.000]: starting [lwt_unix] wait [000.004]: finished in 0.004 s [lwt_unix] waitpid [000.004]: starting [lwt_unix] waitpid [000.010]: finished in 0.006 s [lwt_unix] waitpid: any child [000.010]: starting [lwt_unix] waitpid: any child [000.018]: finished in 0.008 s [lwt_unix] wait4 [000.018]: starting [lwt_unix] wait4 [000.026]: finished in 0.008 s [lwt_unix] wait4: any child [000.026]: starting [lwt_unix] wait4: any child [000.030]: finished in 0.004 s [lwt_unix] basic pread blocking [000.030]: starting [lwt_unix] basic pread blocking [000.031]: finished in 0.001 s [lwt_unix] basic pwrite blocking [000.031]: starting [lwt_unix] basic pwrite blocking [000.031]: finished in 0.000 s [lwt_unix] remove file blocking [000.031]: starting [lwt_unix] remove file blocking [000.031]: finished in 0.000 s [lwt_unix] basic pread nonblocking [000.031]: starting [lwt_unix] basic pread nonblocking [000.031]: finished in 0.000 s [lwt_unix] basic pwrite nonblocking [000.031]: starting [lwt_unix] basic pwrite nonblocking [000.031]: finished in 0.000 s [lwt_unix] remove file nonblocking [000.031]: starting [lwt_unix] remove file nonblocking [000.031]: finished in 0.000 s [lwt_unix] dup on socket blocking [000.031]: starting [lwt_unix] dup on socket blocking [000.034]: finished in 0.003 s [lwt_unix] dup on file blocking [000.034]: starting [lwt_unix] dup on file blocking [000.039]: finished in 0.005 s [lwt_unix] dup on socket nonblocking [000.039]: starting [lwt_unix] dup on socket nonblocking [000.042]: finished in 0.003 s [lwt_unix] dup on file nonblocking [000.042]: starting [lwt_unix] dup on file nonblocking [000.042]: finished in 0.000 s [lwt_io] auto-flush [000.042]: starting [lwt_io] auto-flush [000.143]: finished in 0.100 s [lwt_io] auto-flush in atomic [000.143]: starting [lwt_io] auto-flush in atomic [000.243]: finished in 0.100 s [lwt_io] establish_server: implicit close on exception [000.243]: starting [lwt_io] establish_server: implicit close on exception [000.294]: finished in 0.051 s [lwt_io] with_temp_dir [000.294]: starting [lwt_io] with_temp_dir [000.295]: finished in 0.001 s [lwt_io non blocking io] file does not exist [000.295]: starting [lwt_io non blocking io] file does not exist [000.295]: finished in 0.000 s [lwt_io non blocking io] file does not exist (invalid path) [000.295]: starting [lwt_io non blocking io] file does not exist (invalid path) [000.295]: finished in 0.000 s [lwt_io non blocking io] file does not exist (LargeFile) [000.295]: starting [lwt_io non blocking io] file does not exist (LargeFile) [000.295]: finished in 0.000 s [lwt_io non blocking io] file does not exist (LargeFile, invalid path) [000.295]: starting [lwt_io non blocking io] file does not exist (LargeFile, invalid path) [000.295]: finished in 0.000 s [lwt_io non blocking io] create file [000.295]: starting [lwt_io non blocking io] create file [000.295]: finished in 0.000 s [lwt_io non blocking io] file exists [000.295]: starting [lwt_io non blocking io] file exists [000.295]: finished in 0.000 s [lwt_io non blocking io] file exists (LargeFile) [000.295]: starting [lwt_io non blocking io] file exists (LargeFile) [000.295]: finished in 0.000 s [lwt_io non blocking io] read file [000.295]: starting [lwt_io non blocking io] read file [000.295]: finished in 0.000 s [lwt_io non blocking io] remove file [000.295]: starting [lwt_io non blocking io] remove file [000.295]: finished in 0.000 s [lwt_engine] Lwt_main.run: nested call [000.295]: starting [lwt_engine] Lwt_main.run: nested call [000.295]: finished in 0.000 s [Lwt_timeout] exception in action [000.295]: starting [Lwt_timeout] exception in action [002.302]: finished in 2.007 s [lwt_unix] utimes: basic [002.302]: starting [lwt_unix] utimes: current time [002.302]: starting [lwt_unix] utimes: missing file [002.302]: starting [lwt_unix] readdir: basic [002.302]: starting [lwt_unix] readdir: rewinddir [002.302]: starting [lwt_unix] readdir: readdir_n [002.303]: starting [lwt_unix] readdir: files_of_directory [002.303]: starting [lwt_unix] readdir: already closed [002.303]: starting [lwt_unix] io_vector_byte_count: basic [002.303]: starting [lwt_unix] io_vector_byte_count: basic [002.303]: finished in 0.000 s [lwt_unix] io_vector_byte_count: offsets, partials [002.303]: starting [lwt_unix] io_vector_byte_count: offsets, partials [002.303]: finished in 0.000 s [lwt_unix] io_vector_byte_count: drops [002.303]: starting [lwt_unix] io_vector_byte_count: drops [002.303]: finished in 0.000 s [lwt_unix] readv: basic non-blocking [002.303]: starting [lwt_unix] readv: basic blocking [002.303]: starting [lwt_unix] readv: drop [002.303]: starting [lwt_unix] readv: iovecs exceeding limit [002.304]: starting [lwt_unix] readv: windows [002.305]: skipping [lwt_unix] writev: basic non-blocking [002.305]: starting [lwt_unix] writev: basic blocking [002.307]: starting [lwt_unix] writev: slices [002.309]: starting [lwt_unix] writev: drop, is_empty [002.311]: starting [lwt_unix] writev: degenerate vectors [002.312]: starting [lwt_unix] writev: bad iovec [002.314]: starting [lwt_unix] writev: bad iovec [002.315]: finished in 0.000 s [lwt_unix] writev: iovecs exceeding limit [002.315]: starting [lwt_unix] writev: negative drop [002.317]: starting [lwt_unix] writev: windows [002.319]: skipping [lwt_unix] send_msg, recv_msg [002.319]: starting [lwt_unix] send_msg, recv_msg (Lwt_bytes, old) [002.319]: starting [lwt_unix] bind: basic [002.319]: starting [lwt_unix] bind: basic [002.319]: finished in 0.000 s [lwt_unix] bind: Unix domain [002.319]: starting [lwt_unix] bind: Unix domain [002.320]: finished in 0.000 s [lwt_unix] bind: closed [002.320]: starting [lwt_unix] bind: closed [002.320]: finished in 0.000 s [lwt_unix] bind: aborted [002.320]: starting [lwt_unix] getcwd [002.320]: starting [lwt_unix] getcwd and chdir [002.320]: starting [lwt_unix] getcwd and Unix.getcwd [002.320]: starting [lwt_unix] getcwd and Unix.getcwd [002.320]: finished in 0.000 s [lwt_unix] run_in_main [002.320]: starting [lwt_unix] run_in_main_dont_wait [002.320]: starting [lwt_unix] run_in_main_dont_wait_fail [002.320]: starting [lwt_unix] run_in_main_with_dont_wait [002.320]: starting [lwt_unix] getlogin and Unix.getlogin [002.320]: skipping [lwt_unix] getpwnam and Unix.getpwnam [002.320]: skipping [lwt_unix] getpwuid and Unix.getpwuid [002.320]: skipping [lwt_unix] getgrgid and Unix.getgrgid [002.320]: starting [lwt_unix] getgrnam and Unix.getgrnam [002.322]: starting [lwt_unix] getgrnam and Unix.getgrnam [002.323]: finished in 0.001 s [lwt_io] establish_server_1: shutdown: client closes first [002.323]: starting [lwt_io] open_connection: shutdown: server closes first [002.323]: starting [lwt_io] establish_server: implicit close [002.323]: starting [lwt_io] establish_server: explicit close [002.323]: starting [lwt_io] with_connection [002.323]: starting [lwt_io] with_close_connection: no duplicate exceptions [002.323]: starting [lwt_io] with_close_connection: no duplicate exceptions [002.324]: finished in 0.000 s [lwt_io] open_temp_file [002.324]: starting [lwt_io] with_temp_filename [002.324]: starting [lwt_io] with_temp_filename close handle [002.324]: starting [lwt_io] create_temp_dir [002.324]: starting [lwt_io] create_temp_dir [002.324]: finished in 0.000 s [lwt_io] file_length on directory [002.324]: starting [lwt_io] file_length on directory [002.324]: finished in 0.000 s [lwt_io] input channel of_bytes initial position [002.324]: starting [lwt_io] input channel of_bytes initial position [002.324]: finished in 0.000 s [lwt_io] input channel of_bytes position after read [002.324]: starting [lwt_io] input channel of_bytes position after read [002.324]: finished in 0.000 s [lwt_io] input channel of_bytes position after set_position [002.324]: starting [lwt_io] input channel of_bytes position after set_position [002.324]: finished in 0.000 s [lwt_io] output channel of_bytes initial position [002.324]: starting [lwt_io] output channel of_bytes initial position [002.324]: finished in 0.000 s [lwt_io] output channel of_bytes position after read [002.324]: starting [lwt_io] output channel of_bytes position after read [002.324]: finished in 0.000 s [lwt_io] output channel of_bytes position after set_position [002.324]: starting [lwt_io] output channel of_bytes position after set_position [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_int [002.324]: starting [lwt_io] NumberIO.LE.read_int [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_int [002.324]: starting [lwt_io] NumberIO.BE.read_int [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_int16 [002.324]: starting [lwt_io] NumberIO.LE.read_int16 [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_int16 [002.324]: starting [lwt_io] NumberIO.BE.read_int16 [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_int16, negative [002.324]: starting [lwt_io] NumberIO.LE.read_int16, negative [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_int16, negative [002.324]: starting [lwt_io] NumberIO.BE.read_int16, negative [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_int32 [002.324]: starting [lwt_io] NumberIO.LE.read_int32 [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_int32 [002.324]: starting [lwt_io] NumberIO.BE.read_int32 [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_int64 [002.324]: starting [lwt_io] NumberIO.LE.read_int64 [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_int64 [002.324]: starting [lwt_io] NumberIO.BE.read_int64 [002.324]: finished in 0.000 s [lwt_io] NumberIO.LE.read_float32 [002.324]: starting [lwt_io] NumberIO.LE.read_float32 [002.324]: finished in 0.000 s [lwt_io] NumberIO.BE.read_float32 [002.325]: starting [lwt_io] NumberIO.BE.read_float32 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.read_float64 [002.325]: starting [lwt_io] NumberIO.LE.read_float64 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.read_float64 [002.325]: starting [lwt_io] NumberIO.BE.read_float64 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_int [002.325]: starting [lwt_io] NumberIO.LE.write_int [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_int [002.325]: starting [lwt_io] NumberIO.BE.write_int [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_int16 [002.325]: starting [lwt_io] NumberIO.LE.write_int16 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_int16 [002.325]: starting [lwt_io] NumberIO.BE.write_int16 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_int32 [002.325]: starting [lwt_io] NumberIO.LE.write_int32 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_int32 [002.325]: starting [lwt_io] NumberIO.BE.write_int32 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_int64 [002.325]: starting [lwt_io] NumberIO.LE.write_int64 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_int64 [002.325]: starting [lwt_io] NumberIO.BE.write_int64 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_float32 [002.325]: starting [lwt_io] NumberIO.LE.write_float32 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_float32 [002.325]: starting [lwt_io] NumberIO.BE.write_float32 [002.325]: finished in 0.000 s [lwt_io] NumberIO.LE.write_float64 [002.325]: starting [lwt_io] NumberIO.LE.write_float64 [002.325]: finished in 0.000 s [lwt_io] NumberIO.BE.write_float64 [002.325]: starting [lwt_io] NumberIO.BE.write_float64 [002.325]: finished in 0.000 s [lwt_io] Write from Lwt_bytes [002.325]: starting [lwt_io] Write from Lwt_bytes [002.325]: finished in 0.000 s [lwt_io] Read from Lwt_bytes [002.325]: starting [lwt_io] Read from Lwt_bytes [002.325]: finished in 0.000 s [lwt_process] lazy_undefined [002.325]: starting [lwt_process] subproc stdout can be redirected to null [002.326]: starting [lwt_process] subproc stderr can be redirected to null [002.326]: starting [lwt_process] subproc cannot write on closed stdout [002.330]: starting [lwt_process] subproc cannot write on closed stderr [002.331]: starting [lwt_process] can write to subproc stdin [002.332]: starting [lwt_process] can read from subproc stdout [002.332]: starting [lwt_process] can read from subproc stderr [002.333]: starting [lwt_process] overrides env [002.333]: starting [lwt_process] passes env [002.334]: starting [lwt_process] inherits env [002.335]: starting [lwt_engine] libev: timer delays are not too short [002.335]: starting [unix_mcast] mcast-join-loop [003.336]: starting [unix_mcast] mcast-nojoin-loop [003.336]: starting [unix_mcast] mcast-join-noloop [003.336]: starting [unix_mcast] mcast-nojoin-noloop [003.336]: starting [lwt_fmt] flushing [003.336]: starting [lwt_fmt] flushing [003.336]: finished in 0.000 s [lwt_fmt] with combinator [003.336]: starting [lwt_fmt] with combinator [003.336]: finished in 0.000 s [lwt_fmt] box [003.336]: starting [lwt_fmt] box [003.336]: finished in 0.000 s [lwt_fmt] boxsplit [003.336]: starting [lwt_fmt] boxsplit [003.336]: finished in 0.000 s [lwt_fmt] box close with flush [003.336]: starting [lwt_fmt] box close with flush [003.336]: finished in 0.000 s [lwt_fmt] stream [003.336]: starting [lwt_fmt] stream [003.336]: finished in 0.000 s [Lwt_timeout] basic [003.336]: starting [Lwt_timeout] not started [003.336]: starting [Lwt_timeout] double start [003.336]: starting [Lwt_timeout] restart [003.336]: starting [Lwt_timeout] stop [003.336]: starting [Lwt_timeout] stop when not stopped [003.336]: starting [Lwt_timeout] stop when not stopped [003.336]: finished in 0.000 s [Lwt_timeout] invalid delay [003.336]: starting [Lwt_timeout] invalid delay [003.336]: finished in 0.000 s [Lwt_timeout] change [003.337]: starting [Lwt_timeout] change does not start [003.337]: starting [Lwt_timeout] change after start [003.337]: starting [Lwt_timeout] change: invalid delay [003.337]: starting [Lwt_timeout] change: invalid delay [003.337]: finished in 0.000 s [Lwt_timeout] set_exn_handler [003.337]: starting [Lwt_timeout] two [003.337]: starting [Lwt_timeout] simultaneous [003.337]: starting [Lwt_timeout] two, first stopped [003.337]: starting [lwt_bytes] create [003.337]: starting [lwt_bytes] create [003.337]: finished in 0.000 s [lwt_bytes] get/set [003.337]: starting [lwt_bytes] get/set [003.337]: finished in 0.000 s [lwt_bytes] get out of bounds : lower limit [003.337]: starting [lwt_bytes] get out of bounds : lower limit [003.337]: finished in 0.000 s [lwt_bytes] get out of bounds : upper limit [003.337]: starting [lwt_bytes] get out of bounds : upper limit [003.337]: finished in 0.000 s [lwt_bytes] set out of bounds : lower limit [003.337]: starting [lwt_bytes] set out of bounds : lower limit [003.337]: finished in 0.000 s [lwt_bytes] set out of bounds : upper limit [003.337]: starting [lwt_bytes] set out of bounds : upper limit [003.337]: finished in 0.000 s [lwt_bytes] unsafe_get/unsafe_set [003.337]: starting [lwt_bytes] unsafe_get/unsafe_set [003.337]: finished in 0.000 s [lwt_bytes] of bytes [003.337]: starting [lwt_bytes] of bytes [003.337]: finished in 0.000 s [lwt_bytes] of string [003.337]: starting [lwt_bytes] of string [003.337]: finished in 0.000 s [lwt_bytes] to bytes [003.337]: starting [lwt_bytes] to bytes [003.337]: finished in 0.000 s [lwt_bytes] to string [003.337]: starting [lwt_bytes] to string [003.337]: finished in 0.000 s [lwt_bytes] blit [003.337]: starting [lwt_bytes] blit [003.337]: finished in 0.000 s [lwt_bytes] blit source out of bounds: lower limit [003.337]: starting [lwt_bytes] blit source out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit source out of bounds: upper limit [003.337]: starting [lwt_bytes] blit source out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit destination out of bounds: lower limit [003.337]: starting [lwt_bytes] blit destination out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit destination out of bounds: upper limit [003.337]: starting [lwt_bytes] blit destination out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit length out of bounds: lower limit [003.337]: starting [lwt_bytes] blit length out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes [003.337]: starting [lwt_bytes] blit from bytes [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes source out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from bytes source out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes source out of bounds: upper limit [003.337]: starting [lwt_bytes] blit from bytes source out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes destination out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from bytes destination out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes destination out of bounds: upper limit [003.337]: starting [lwt_bytes] blit from bytes destination out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit from bytes length out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from bytes length out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string [003.337]: starting [lwt_bytes] blit from string [003.337]: finished in 0.000 s [lwt_bytes] blit from string source out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from string source out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string source out of bounds: upper limit [003.337]: starting [lwt_bytes] blit from string source out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string destination out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from string destination out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string destination out of bounds: upper limit [003.337]: starting [lwt_bytes] blit from string destination out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string length out of bounds: lower limit [003.337]: starting [lwt_bytes] blit from string length out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit from string length out of bounds: upper limit [003.337]: starting [lwt_bytes] blit from string length out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes [003.337]: starting [lwt_bytes] blit to bytes [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes source out of bounds: lower limit [003.337]: starting [lwt_bytes] blit to bytes source out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes source out of bounds: upper limit [003.337]: starting [lwt_bytes] blit to bytes source out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes destination out of bounds: lower limit [003.337]: starting [lwt_bytes] blit to bytes destination out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes destination out of bounds: upper limit [003.337]: starting [lwt_bytes] blit to bytes destination out of bounds: upper limit [003.337]: finished in 0.000 s [lwt_bytes] blit to bytes length out of bounds: lower limit [003.337]: starting [lwt_bytes] blit to bytes length out of bounds: lower limit [003.337]: finished in 0.000 s [lwt_bytes] unsafe blit [003.338]: starting [lwt_bytes] unsafe blit [003.338]: finished in 0.000 s [lwt_bytes] unsafe blit from bytes [003.338]: starting [lwt_bytes] unsafe blit from bytes [003.338]: finished in 0.000 s [lwt_bytes] unsafe blit from string [003.338]: starting [lwt_bytes] unsafe blit from string [003.338]: finished in 0.000 s [lwt_bytes] unsafe blit to bytes [003.338]: starting [lwt_bytes] unsafe blit to bytes [003.338]: finished in 0.000 s [lwt_bytes] proxy [003.338]: starting [lwt_bytes] proxy [003.338]: finished in 0.000 s [lwt_bytes] proxy offset out of bounds: lower limit [003.338]: starting [lwt_bytes] proxy offset out of bounds: lower limit [003.338]: finished in 0.000 s [lwt_bytes] proxy offset out of bounds: upper limit [003.338]: starting [lwt_bytes] proxy offset out of bounds: upper limit [003.338]: finished in 0.000 s [lwt_bytes] proxy length out of bounds: lower limit [003.338]: starting [lwt_bytes] proxy length out of bounds: lower limit [003.338]: finished in 0.000 s [lwt_bytes] extract [003.338]: starting [lwt_bytes] extract [003.338]: finished in 0.000 s [lwt_bytes] extract offset out of bounds: lower limit [003.338]: starting [lwt_bytes] extract offset out of bounds: lower limit [003.338]: finished in 0.000 s [lwt_bytes] extract offset out of bounds: upper limit [003.338]: starting [lwt_bytes] extract offset out of bounds: upper limit [003.338]: finished in 0.000 s [lwt_bytes] extract length out of bounds: lower limit [003.338]: starting [lwt_bytes] extract length out of bounds: lower limit [003.338]: finished in 0.000 s [lwt_bytes] copy [003.338]: starting [lwt_bytes] copy [003.338]: finished in 0.000 s [lwt_bytes] fill [003.338]: starting [lwt_bytes] fill [003.338]: finished in 0.000 s [lwt_bytes] fill offset out of bounds: lower limit [003.338]: starting [lwt_bytes] fill offset out of bounds: lower limit [003.338]: finished in 0.000 s [lwt_bytes] fill offset out of bounds: upper limit [003.338]: starting [lwt_bytes] fill offset out of bounds: upper limit [003.338]: finished in 0.000 s [lwt_bytes] fill length out of bounds lower limit [003.338]: starting [lwt_bytes] fill length out of bounds lower limit [003.338]: finished in 0.000 s [lwt_bytes] unsafe fill [003.338]: starting [lwt_bytes] unsafe fill [003.338]: finished in 0.000 s [lwt_bytes] bytes read [003.338]: starting [lwt_bytes] bytes write [003.338]: starting [lwt_bytes] bytes recv [003.338]: starting [lwt_bytes] bytes send [003.338]: starting [lwt_bytes] bytes recvfrom [003.338]: starting [lwt_bytes] bytes sendto [003.338]: starting [lwt_bytes] bytes recv_msg [003.339]: starting [lwt_bytes] bytes send_msg [003.339]: starting [lwt_bytes] send_msgto [003.339]: starting [lwt_bytes] map_file [003.578]: starting [lwt_bytes] map_file [003.578]: finished in 0.000 s [lwt_bytes] page_size [003.578]: starting [lwt_bytes] page_size [003.578]: finished in 0.000 s [lwt_bytes] mincore buffer length = page_size * 2, n_states = 1 [003.578]: starting [lwt_bytes] mincore buffer length = page_size * 2, n_states = 2 [003.578]: starting [lwt_bytes] mincore buffer length = page_size * 2 + 1, n_states = 2 [003.578]: starting [lwt_bytes] mincore buffer length = page_size , n_states = 0 [003.578]: starting [lwt_bytes] wait_mincore correct bounds [003.578]: starting [lwt_bytes] wait_mincore offset < 0 [003.578]: starting [lwt_bytes] wait_mincore offset > buffer length [003.578]: starting [Lwt_unix sleep and timeout] sleep [003.578]: starting [Lwt_unix sleep and timeout] timeout [003.578]: starting [Lwt_unix sleep and timeout] with_timeout : no timeout [003.578]: starting [Lwt_unix sleep and timeout] with_timeout : timeout [003.578]: starting [Lwt_unix sleep and timeout] pause [003.578]: starting [Lwt_unix sleep and timeout] pause [003.578]: finished in 0.000 s [Lwt_unix sleep and timeout] auto_pause [003.578]: starting [lwt_unix] utimes: basic [003.578]: finished in 1.276 s [lwt_unix] utimes: missing file [003.579]: finished in 1.276 s [lwt_unix] bind: aborted [003.592]: finished in 1.272 s [lwt_unix] getcwd [003.592]: finished in 1.272 s [lwt_unix] getgrgid and Unix.getgrgid [003.592]: finished in 1.272 s [unix_mcast] mcast-join-loop [003.592]: finished in 0.256 s [unix_mcast] mcast-nojoin-loop [003.592]: finished in 0.256 s [unix_mcast] mcast-join-noloop [003.592]: finished in 0.256 s [unix_mcast] mcast-nojoin-noloop [003.592]: finished in 0.256 s [Lwt_unix sleep and timeout] with_timeout : no timeout [003.592]: finished in 0.014 s [lwt_process] can write to subproc stdin [003.592]: finished in 1.261 s [lwt_process] subproc cannot write on closed stderr [003.592]: finished in 1.261 s [lwt_process] subproc cannot write on closed stdout [003.592]: finished in 1.262 s [lwt_process] subproc stderr can be redirected to null [003.592]: finished in 1.266 s [lwt_process] subproc stdout can be redirected to null [003.592]: finished in 1.267 s [lwt_process] lazy_undefined [003.592]: finished in 1.267 s [lwt_process] can read from subproc stdout [003.593]: finished in 1.261 s [lwt_process] can read from subproc stderr [003.593]: finished in 1.260 s [lwt_process] overrides env [003.593]: finished in 1.259 s [lwt_process] passes env [003.593]: finished in 1.259 s [lwt_process] inherits env [003.593]: finished in 1.258 s [lwt_unix] utimes: current time [003.593]: finished in 1.291 s [lwt_unix] readdir: already closed [003.593]: finished in 1.290 s [lwt_unix] readv: basic non-blocking [003.593]: finished in 1.290 s [lwt_unix] readv: drop [003.593]: finished in 1.290 s [lwt_unix] readv: iovecs exceeding limit [003.594]: finished in 1.290 s [lwt_unix] writev: basic non-blocking [003.594]: finished in 1.289 s [lwt_unix] writev: slices [003.594]: finished in 1.285 s [lwt_unix] writev: drop, is_empty [003.594]: finished in 1.283 s [lwt_unix] writev: degenerate vectors [003.594]: finished in 1.281 s [lwt_unix] writev: iovecs exceeding limit [003.594]: finished in 1.279 s [lwt_unix] writev: negative drop [003.594]: finished in 1.277 s [lwt_io] open_temp_file [003.594]: finished in 1.270 s [lwt_bytes] bytes recvfrom [003.594]: finished in 0.256 s [lwt_bytes] bytes recv_msg [003.594]: finished in 0.256 s [lwt_bytes] bytes sendto [003.594]: finished in 0.256 s [lwt_bytes] bytes send_msg [003.594]: finished in 0.256 s [lwt_bytes] send_msgto [003.594]: finished in 0.255 s [lwt_unix] readdir: files_of_directory [003.594]: finished in 1.291 s [lwt_unix] readv: basic blocking [003.594]: finished in 1.291 s [lwt_unix] writev: basic blocking [003.594]: finished in 1.288 s [lwt_unix] getcwd and chdir [003.594]: finished in 1.275 s [lwt_bytes] bytes read [003.594]: finished in 0.256 s [lwt_bytes] mincore buffer length = page_size * 2, n_states = 1 [003.594]: finished in 0.016 s [lwt_bytes] mincore buffer length = page_size * 2, n_states = 2 [003.595]: finished in 0.016 s [lwt_bytes] mincore buffer length = page_size * 2 + 1, n_states = 2 [003.595]: finished in 0.016 s [lwt_bytes] mincore buffer length = page_size , n_states = 0 [003.595]: finished in 0.016 s [lwt_bytes] wait_mincore correct bounds [003.595]: finished in 0.016 s [lwt_bytes] wait_mincore offset < 0 [003.595]: finished in 0.016 s [lwt_bytes] wait_mincore offset > buffer length [003.595]: finished in 0.016 s [lwt_unix] run_in_main_dont_wait_fail [003.595]: finished in 1.275 s [lwt_unix] run_in_main_with_dont_wait [003.595]: finished in 1.275 s [lwt_unix] run_in_main_dont_wait [003.595]: finished in 1.275 s [lwt_bytes] bytes recv [003.595]: finished in 0.257 s [lwt_bytes] bytes send [003.595]: finished in 0.257 s [lwt_io] establish_server_1: shutdown: client closes first [003.595]: finished in 1.272 s [lwt_io] with_connection [003.595]: finished in 1.271 s [lwt_unix] readdir: readdir_n [003.595]: finished in 1.292 s [lwt_unix] send_msg, recv_msg [003.595]: finished in 1.276 s [lwt_unix] send_msg, recv_msg (Lwt_bytes, old) [003.595]: finished in 1.276 s [lwt_io] with_temp_filename close handle [003.595]: finished in 1.271 s [lwt_io] open_connection: shutdown: server closes first [003.595]: finished in 1.272 s [lwt_io] establish_server: explicit close [003.595]: finished in 1.272 s [lwt_bytes] bytes write [003.595]: finished in 0.257 s [lwt_io] with_temp_filename [003.595]: finished in 1.271 s [lwt_unix] readdir: basic [003.595]: finished in 1.293 s [lwt_unix] readdir: rewinddir [003.595]: finished in 1.293 s [lwt_unix] run_in_main [003.603]: finished in 1.283 s [lwt_io] establish_server: implicit close [003.645]: finished in 1.322 s [lwt_engine] libev: timer delays are not too short [003.836]: finished in 1.501 s [Lwt_unix sleep and timeout] sleep [004.579]: finished in 1.000 s [Lwt_unix sleep and timeout] timeout [004.579]: finished in 1.000 s [Lwt_unix sleep and timeout] with_timeout : timeout [004.579]: finished in 1.000 s [Lwt_unix sleep and timeout] auto_pause [004.579]: finished in 1.000 s [Lwt_timeout] simultaneous [005.338]: finished in 2.001 s [Lwt_timeout] set_exn_handler [005.338]: finished in 2.001 s [Lwt_timeout] change after start [005.338]: finished in 2.001 s [Lwt_timeout] change [005.338]: finished in 2.001 s [Lwt_timeout] basic [005.338]: finished in 2.002 s [Lwt_timeout] not started [006.338]: finished in 3.001 s [Lwt_timeout] double start [006.338]: finished in 3.001 s [Lwt_timeout] stop [006.338]: finished in 3.001 s [Lwt_timeout] change does not start [006.338]: finished in 3.001 s [Lwt_timeout] two, first stopped [006.338]: finished in 3.001 s [Lwt_timeout] two [006.338]: finished in 3.001 s [Lwt_timeout] restart [006.338]: finished in 3.002 s 2026-01-26 08:31.35 ---> saved as "97ccb978941752073c7db4d85592719f2a343e4a46182f073ee641c667b2f500" Job succeeded 2026-01-26 08:31.35: Job succeeded