2026-01-27 07:25.28: New job: test ocsigen/lwt https://github.com/ocsigen/lwt.git#refs/pull/967/head (8393eb0861eb4f7dc04497209c64f0fc8c47d494) (linux-x86_64:ubuntu-24.04-4.14_opam-2.5)Base: ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8Opam project buildTo reproduce locally:git clone --recursive "https://github.com/ocsigen/lwt.git" && cd "lwt" && git fetch origin "refs/pull/967/head" && git reset --hard 8393eb08cat > Dockerfile <<'END-OF-DOCKERFILE'FROM ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8# ubuntu-24.04-4.14_opam-2.5USER 1000:1000ENV CLICOLOR_FORCE="1"ENV OPAMCOLOR="always"WORKDIR /srcRUN sudo ln -f /usr/bin/opam-2.5 /usr/bin/opamRUN opam init --reinit -niRUN uname -rs && opam exec -- ocaml -version && opam --versionWORKDIR /srcRUN sudo chown opam /srcRUN 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 -uCOPY --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-bigarray.base base-bytes.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.4.14.2 ocaml-base-compiler.4.14.2 ocaml-compiler-libs.v0.12.4 ocaml-config.2 ocaml-options-vanilla.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.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_retry.dev lwt_react.dev lwt_ppx.dev lwt.dev $DEPSRUN opam install $DEPSCOPY --chown=1000:1000 . /srcRUN opam exec -- dune build --only-packages=lwt_retry,lwt_react,lwt_ppx,lwt @install @check @runtest && rm -rf _buildEND-OF-DOCKERFILEdocker build .END-REPRO-BLOCK2026-01-27 07:25.28: Using cache hint "ocsigen/lwt-ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8-ubuntu-24.04-4.14_opam-2.5-f80664a0fc43791440912ae83095cdb3"2026-01-27 07:25.28: Using OBuilder spec:((from ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8)(comment ubuntu-24.04-4.14_opam-2.5)(user (uid 1000) (gid 1000))(env CLICOLOR_FORCE 1)(env OPAMCOLOR always)(workdir /src)(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-bigarray.base base-bytes.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.4.14.2 ocaml-base-compiler.4.14.2 ocaml-compiler-libs.v0.12.4 ocaml-config.2 ocaml-options-vanilla.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.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_retry.dev lwt_react.dev lwt_ppx.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 --only-packages=lwt_retry,lwt_react,lwt_ppx,lwt @install @check @runtest && rm -rf _build")))2026-01-27 07:25.28: Waiting for resource in pool OCluster2026-01-27 08:08.10: Waiting for worker…2026-01-27 08:12.38: Got resource from pool OClusterBuilding on odawa.caelum.ci.devAll commits already cachedHEAD is now at 8393eb086 more misc.h includes(from ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8)Unable to find image 'ocaml/opam:ubuntu-24.04-ocaml-4.14@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8' locallydocker.io/ocaml/opam@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8: Pulling from ocaml/opama3629ac5b9f4: Pulling fs layer1df74ae2bf3e: Pulling fs layer2563f25c1178: Pulling fs layerf5fc2898bd97: Pulling fs layer07bec2374ef4: Pulling fs layer182b6598c3cc: Pulling fs layer8c2da7c8c95f: Pulling fs layerf5fc2898bd97: Waiting07bec2374ef4: Waiting20cf8da7cf35: Pulling fs layer7610f2cf1786: Pulling fs layer8c2da7c8c95f: Waiting7399021ff14f: Pulling fs layer9456e89e55d4: Pulling fs layere5df944e4bd8: Pulling fs layer2333fbde88eb: Pulling fs layer13a073e08a30: Pulling fs layerec62492105dc: Pulling fs layer20cf8da7cf35: Waitingf036ba372f52: Pulling fs layer7399021ff14f: Waiting9456e89e55d4: Waiting3682b95f48a4: Pulling fs layer13a073e08a30: Waiting7610f2cf1786: Waitinge5df944e4bd8: Waiting182b6598c3cc: Waiting2333fbde88eb: Waitingec62492105dc: Waiting32baad6bd40c: Pulling fs layer3682b95f48a4: Waitingf036ba372f52: Waiting55ea33603a54: Pulling fs layer32baad6bd40c: Waiting01e4c8c454ad: Pulling fs layer55ea33603a54: Waiting49e757bc4eaa: Pulling fs layer4f4fb700ef54: Pulling fs layer9ca2cd4333a3: Pulling fs layer01e4c8c454ad: Waiting49e757bc4eaa: Waiting24fda3688513: Pulling fs layer9ca2cd4333a3: Waiting4f4fb700ef54: Waiting79b4050536fd: Pulling fs layera301a466fc25: Pulling fs layerc92e4a5fb48f: Pulling fs layer24fda3688513: Waitingc232f3271d8c: Pulling fs layer38ee7210bcfc: Pulling fs layer8aa9bd545ce6: Pulling fs layer894091e858fb: Pulling fs layer79b4050536fd: Waiting8aa9bd545ce6: Waitinga301a466fc25: Waiting894091e858fb: Waiting77f8f8d20b66: Pulling fs layer38ee7210bcfc: Waitingc232f3271d8c: Waiting9dba2465b196: Pulling fs layer9e601e55f327: Pulling fs layerf35ddc136152: Pulling fs layer77f8f8d20b66: Waiting9dba2465b196: Waiting9ae0bef3d320: Pulling fs layercea410b8abb3: Pulling fs layer08accec35800: Pulling fs layercea410b8abb3: Waiting17947165f33a: Pulling fs layer08accec35800: Waiting9ae0bef3d320: Waiting9811f6717868: Pulling fs layer785aa6530c08: Pulling fs layere5ae7628bb7b: Pulling fs layer4c8749b32c0c: Pulling fs layered12334bba7e: Pulling fs layer17947165f33a: Waitinge5ae7628bb7b: Waiting4c8749b32c0c: Waiting9811f6717868: Waiting785aa6530c08: Waitinged12334bba7e: Waiting2563f25c1178: Download complete1df74ae2bf3e: Verifying Checksum1df74ae2bf3e: Download complete07bec2374ef4: Verifying Checksum07bec2374ef4: Download completea3629ac5b9f4: Verifying Checksuma3629ac5b9f4: Download completef5fc2898bd97: Verifying Checksumf5fc2898bd97: Download complete8c2da7c8c95f: Verifying Checksum8c2da7c8c95f: Download completea3629ac5b9f4: Pull complete1df74ae2bf3e: Pull complete2563f25c1178: Pull complete7610f2cf1786: Verifying Checksum7610f2cf1786: Download complete20cf8da7cf35: Verifying Checksumf5fc2898bd97: Pull complete07bec2374ef4: Pull complete7399021ff14f: Verifying Checksum7399021ff14f: Download complete9456e89e55d4: Verifying Checksum9456e89e55d4: Download complete2333fbde88eb: Verifying Checksum2333fbde88eb: Download completee5df944e4bd8: Download complete182b6598c3cc: Verifying Checksum182b6598c3cc: Download completeec62492105dc: Download completef036ba372f52: Verifying Checksumf036ba372f52: Download complete13a073e08a30: Verifying Checksum13a073e08a30: Download complete3682b95f48a4: Verifying Checksum3682b95f48a4: Download complete32baad6bd40c: Verifying Checksum32baad6bd40c: Download complete55ea33603a54: Verifying Checksum55ea33603a54: Download complete01e4c8c454ad: Verifying Checksum01e4c8c454ad: Download complete49e757bc4eaa: Verifying Checksum49e757bc4eaa: Download complete4f4fb700ef54: Verifying Checksum4f4fb700ef54: Download complete9ca2cd4333a3: Verifying Checksum9ca2cd4333a3: Download complete24fda3688513: Verifying Checksum24fda3688513: Download complete79b4050536fd: Verifying Checksum79b4050536fd: Download completea301a466fc25: Verifying Checksuma301a466fc25: Download completec92e4a5fb48f: Verifying Checksumc92e4a5fb48f: Download completec232f3271d8c: Download complete38ee7210bcfc: Verifying Checksum38ee7210bcfc: Download complete8aa9bd545ce6: Verifying Checksum8aa9bd545ce6: Download complete894091e858fb: Download complete77f8f8d20b66: Verifying Checksum77f8f8d20b66: Download complete9dba2465b196: Verifying Checksum9dba2465b196: Download complete9e601e55f327: Verifying Checksum9e601e55f327: Download complete9ae0bef3d320: Download complete182b6598c3cc: Pull complete8c2da7c8c95f: Pull complete20cf8da7cf35: Pull complete7610f2cf1786: Pull complete7399021ff14f: Pull complete9456e89e55d4: Pull completee5df944e4bd8: Pull complete2333fbde88eb: Pull complete08accec35800: Download complete13a073e08a30: Pull completeec62492105dc: Pull completef036ba372f52: Pull complete3682b95f48a4: Pull complete32baad6bd40c: Pull complete55ea33603a54: Pull complete01e4c8c454ad: Pull complete49e757bc4eaa: Pull complete4f4fb700ef54: Pull complete9ca2cd4333a3: Pull complete24fda3688513: Pull complete79b4050536fd: Pull completea301a466fc25: Pull completec92e4a5fb48f: Pull completec232f3271d8c: Pull complete38ee7210bcfc: Pull complete8aa9bd545ce6: Pull complete894091e858fb: Pull complete77f8f8d20b66: Pull complete9dba2465b196: Pull complete9e601e55f327: Pull complete17947165f33a: Verifying Checksum17947165f33a: Download complete9811f6717868: Verifying Checksum9811f6717868: Download completef35ddc136152: Verifying Checksumf35ddc136152: Download completee5ae7628bb7b: Verifying Checksume5ae7628bb7b: Download complete4c8749b32c0c: Verifying Checksum4c8749b32c0c: Download completeed12334bba7e: Verifying Checksumed12334bba7e: Download completecea410b8abb3: Verifying Checksumcea410b8abb3: Download complete785aa6530c08: Verifying Checksum785aa6530c08: Download completef35ddc136152: Pull complete9ae0bef3d320: Pull completecea410b8abb3: Pull complete08accec35800: Pull complete17947165f33a: Pull complete9811f6717868: Pull complete785aa6530c08: Pull completee5ae7628bb7b: Pull complete4c8749b32c0c: Pull completeed12334bba7e: Pull completeDigest: sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b8Status: Downloaded newer image for ocaml/opam@sha256:458f06d1dec2c657e98484451140d4129abb934ad590479ec7b4b4a7bc60b6b82026-01-27 08:12.39 ---> using "ef22c250542bfdbbae9cc5c0c5dceee33d5c6eaa63ef93c0e62d649e6d282495" from cache/: (comment ubuntu-24.04-4.14_opam-2.5)/: (user (uid 1000) (gid 1000))/: (env CLICOLOR_FORCE 1)/: (env OPAMCOLOR always)/: (workdir /src)/src: (run (shell "sudo ln -f /usr/bin/opam-2.5 /usr/bin/opam"))2026-01-27 08:12.39 ---> using "94b306c568a54449b56cd89b8114cf21f76fb95cb9cfc62d690b44d2a92b39ef" 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] yFormat upgrade done.<><> Updating repositories ><><><><><><><><><><><><><><><><><><><><><><><><><><>[default] Initialised2026-01-27 08:12.39 ---> using "088b1f75292e92f2b7147a2fa802470c80442d5e490e50c28b1c075db81389dc" from cache/src: (run (shell "uname -rs && opam exec -- ocaml -version && opam --version"))Linux 6.8.0-87-genericThe OCaml toplevel, version 4.14.22.5.02026-01-27 08:12.39 ---> using "af2883df424175f72b177cf06b16a804446bf9b6937bbb12fa369d98450581a6" from cache/src: (workdir /src)/src: (run (shell "sudo chown opam /src"))2026-01-27 08:12.39 ---> using "935ff14fa4d7e36e3a0cf92fc51faeea8b126c3b41508e6fa2843d0e16584ece" 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"))873cb18c37 Merge pull request #29216 from shonfeder/release-dune-3.21.0<><> Updating package repositories ><><><><><><><><><><><><><><><><><><><><><><>[default] synchronised from git+file:///home/opam/opam-repositoryEverything as up-to-date as possible (run with --verbose to show unavailable upgrades).However, you may "opam upgrade" these packages explicitly at these versions (e.g. "opam upgrade ocaml.5.4.0"), which will ask permission to downgrade or uninstall the conflicting packages.Nothing to do.# To update the current shell environment, run: eval $(opam env)2026-01-27 08:12.39 ---> using "fdc82b42706e1d2db04fd524f1ac6118ab6649fe2aaea3f0f2563aecd8349194" 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-27 08:12.39 ---> saved as "c00294e55a82b98ffbfee2a6d96dc85330b2835aec55f9a1513ceba5a35d599b"/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-27 08:12.49 ---> saved as "e6e9a49eb6f5b65ef5fc8230fae17dace8c03e5f12fcb9a4e9c4ac5945622b53"/src: (run (network host)(shell "echo '(lang dune 3.0)' > './dune-project'"))2026-01-27 08:12.49 ---> saved as "be26663e2c12e5f894132c74cf6d88803d15f782ee89cbbb1bfdc07884ce8693"/src: (env DEPS "base-bigarray.base base-bytes.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.4.14.2 ocaml-base-compiler.4.14.2 ocaml-compiler-libs.v0.12.4 ocaml-config.2 ocaml-options-vanilla.1 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 ppx_derivers.1.2.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_retry.dev lwt_react.dev lwt_ppx.dev lwt.dev $DEPS"))+ /usr/bin/sudo "apt-get" "update"- Hit:1 http://archive.ubuntu.com/ubuntu noble InRelease- Get:2 http://archive.ubuntu.com/ubuntu noble-updates InRelease [126 kB]- Get:3 http://archive.ubuntu.com/ubuntu noble-backports InRelease [126 kB]- Get:4 http://security.ubuntu.com/ubuntu noble-security InRelease [126 kB]- Get:5 http://archive.ubuntu.com/ubuntu noble-updates/main amd64 Packages [2150 kB]- Get:6 http://archive.ubuntu.com/ubuntu noble-updates/universe amd64 Packages [1966 kB]- Get:7 http://archive.ubuntu.com/ubuntu noble-updates/multiverse amd64 Packages [37.6 kB]- Get:8 http://archive.ubuntu.com/ubuntu noble-updates/restricted amd64 Packages [3182 kB]- Get:9 http://security.ubuntu.com/ubuntu noble-security/main amd64 Packages [1776 kB]- Get:10 http://security.ubuntu.com/ubuntu noble-security/universe amd64 Packages [1194 kB]- Fetched 10.7 MB in 1s (10.0 MB/s)- Reading package lists...<><> Synchronising pinned packages ><><><><><><><><><><><><><><><><><><><><><><>[lwt.dev] synchronised (file:///src)[lwt_ppx.dev] synchronised (file:///src)[lwt_react.dev] synchronised (file:///src)[lwt_retry.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 2).[NOTE] Package ocaml-base-compiler is already installed (current version is 4.14.2).[NOTE] Package ocaml is already installed (current version is 4.14.2).[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-bigarray is already installed (current version is base).# To update the current shell environment, run: eval $(opam env)2026-01-27 08:12.59 ---> saved as "e0d1533e79010c20ffeead593684b8562b0d702a9ad5238ff85792ffb274a4f8"/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 2).[NOTE] Package ocaml-base-compiler is already installed (current version is 4.14.2).[NOTE] Package ocaml is already installed (current version is 4.14.2).[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-bigarray is already installed (current version is base).The following actions will be performed:=== install 15 packages- 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.12.4- install ocamlbuild 0.16.1- install ocamlfind 1.9.8- install ocplib-endian 1.2- install ppx_derivers 1.2.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 cppo.1.8.0 (cached)-> retrieved csexp.1.5.2 (cached)-> retrieved ocaml-compiler-libs.v0.12.4 (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 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.12.4-> installed sexplib0.v0.17.0-> installed stdlib-shims.0.3.0-> installed ocplib-endian.1.2-> installed dune-configurator.3.21.0-> installed ppxlib.0.37.0Done.# To update the current shell environment, run: eval $(opam env)2026-01-27 08:13.37 ---> saved as "5882b6c56da7d4b179b98b35246f0f18c680a7e64aa7951a0694da380f2efc23"/src: (copy (src .) (dst /src))2026-01-27 08:13.37 ---> saved as "ed62785c4970518684d0e7dcf8202bb7df4df72c4031695152e03b884811fe79"/src: (run (shell "opam exec -- dune build --only-packages=lwt_retry,lwt_react,lwt_ppx,lwt @install @check @runtest && rm -rf _build"))(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.010]: 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.00 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.003]: finished in 0.003 s[lwt_unix.cloexec] openfile: O_KEEPEXEC [000.003]: finished in 0.003 s[lwt_unix.cloexec] openfile: O_CLOEXEC [000.003]: finished in 0.003 s[lwt_unix.cloexec] openfile: O_CLOEXEC, O_KEEPEXEC [000.004]: finished in 0.003 s[lwt_unix.cloexec] openfile: O_KEEPEXEC, O_CLOEXEC [000.004]: finished in 0.004 s(cd _build/default/test/unix && ./wait.exe)Testing library 'unix.wait'........Ok. 5 tests ran, 0 tests skipped in 0.01 seconds[lwt_unix.wait] wait [000.000]: starting[lwt_unix.wait] wait [000.002]: finished in 0.002 s[lwt_unix.wait] waitpid [000.002]: starting[lwt_unix.wait] waitpid [000.005]: finished in 0.002 s[lwt_unix.wait] waitpid: any child [000.005]: starting[lwt_unix.wait] waitpid: any child [000.007]: finished in 0.003 s[lwt_unix.wait] wait4 [000.007]: starting[lwt_unix.wait] wait4 [000.010]: finished in 0.002 s[lwt_unix.wait] wait4: any child [000.010]: starting[lwt_unix.wait] wait4: any child [000.012]: finished in 0.002 s(cd _build/default/test/core && ./main.exe)Testing library 'core'..................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................SSSSSSSSSSSSSSSSSSSSSSS..................................................................................................................................................Ok. 705 tests ran, 23 tests skipped in 0.14 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.000]: finished in 0.000 s[initial promises] task: resolve [000.000]: starting[initial promises] task: resolve [000.000]: finished in 0.000 s[double resolve] wakeup: double use on wait [000.000]: starting[double resolve] wakeup: double use on wait [000.000]: finished in 0.000 s[double resolve] wakeup: double use on task [000.000]: starting[double resolve] wakeup: double use on task [000.000]: finished in 0.000 s[double resolve] wakeup_exn: double use on wait [000.000]: starting[double resolve] wakeup_exn: double use on wait [000.000]: finished in 0.000 s[double resolve] wakeup_exn: double use on task [000.000]: starting[double resolve] wakeup_exn: double use on task [000.000]: finished in 0.000 s[double resolve] wakeup_result: double use on wait [000.000]: starting[double resolve] wakeup_result: double use on wait [000.000]: finished in 0.000 s[double resolve] wakeup_result: double use on task [000.000]: starting[double resolve] wakeup_result: double use on task [000.000]: finished in 0.000 s[bind] already fulfilled [000.000]: starting[bind] already fulfilled [000.000]: finished in 0.000 s[bind] already fulfilled, f raises [000.000]: starting[bind] already fulfilled, f raises [000.000]: finished in 0.000 s[bind] already rejected [000.000]: starting[bind] already rejected [000.000]: finished in 0.000 s[bind] pending [000.000]: starting[bind] pending [000.000]: finished in 0.000 s[bind] pending, fulfilled [000.000]: starting[bind] pending, fulfilled [000.000]: finished in 0.000 s[bind] pending, fulfilled, f raises [000.000]: starting[bind] pending, fulfilled, f raises [000.000]: finished in 0.000 s[bind] pending, rejected [000.000]: starting[bind] pending, rejected [000.000]: finished in 0.000 s[bind] chain [000.000]: starting[bind] chain [000.000]: finished in 0.000 s[bind] suspended chain [000.000]: starting[bind] suspended chain [000.000]: finished in 0.000 s[bind] fanout [000.000]: starting[bind] fanout [000.000]: finished in 0.000 s[bind] double pending [000.000]: starting[bind] double pending [000.000]: finished in 0.000 s[bind] same pending [000.000]: starting[bind] same pending [000.000]: finished in 0.000 s[bind] nested [000.000]: starting[bind] nested [000.000]: finished in 0.000 s[bind] proxy chain [000.000]: starting[bind] proxy chain [000.000]: finished in 0.000 s[bind] cycle [000.000]: starting[bind] cycle [000.000]: finished in 0.000 s[bind] proxy during callback [000.000]: starting[bind] proxy during callback [000.000]: finished in 0.000 s[backtrace_bind] fulfilled [000.000]: 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.001]: finished in 0.000 s[catch] rejected (raise) [000.001]: starting[catch] rejected (raise) [000.001]: finished in 0.000 s[catch] rejected, h raises [000.001]: starting[catch] rejected, h raises [000.001]: finished in 0.000 s[catch] pending [000.001]: starting[catch] pending [000.001]: finished in 0.000 s[catch] pending, fulfilled [000.001]: starting[catch] pending, fulfilled [000.001]: finished in 0.000 s[catch] pending, rejected [000.001]: starting[catch] pending, rejected [000.001]: finished in 0.000 s[catch] pending, rejected, h raises [000.001]: starting[catch] pending, rejected, h raises [000.001]: finished in 0.000 s[catch] pending, rejected, h pending [000.001]: starting[catch] pending, rejected, h pending [000.001]: finished in 0.000 s[catch] proxy during callback [000.001]: starting[catch] proxy during callback [000.001]: finished in 0.000 s[catch] catch with ocaml-runtime exception [000.001]: starting[catch] catch with ocaml-runtime exception [000.001]: finished in 0.000 s[catch] try_bind with ocaml-runtime exception [000.001]: starting[catch] try_bind with ocaml-runtime exception [000.001]: finished in 0.000 s[catch] try_bind(2) with ocaml-runtime exception [000.001]: starting[catch] try_bind(2) with ocaml-runtime exception [000.001]: finished in 0.000 s[backtrace_catch] fulfilled [000.001]: starting[backtrace_catch] fulfilled [000.001]: finished in 0.000 s[backtrace_catch] f raises [000.001]: starting[backtrace_catch] f raises [000.001]: finished in 0.000 s[backtrace_catch] rejected [000.001]: starting[backtrace_catch] rejected [000.001]: finished in 0.000 s[backtrace_catch] pending [000.001]: starting[backtrace_catch] pending [000.001]: finished in 0.000 s[backtrace_catch] pending, fulfilled [000.001]: starting[backtrace_catch] pending, fulfilled [000.001]: finished in 0.000 s[backtrace_catch] pending, rejected [000.001]: starting[backtrace_catch] pending, rejected [000.001]: finished in 0.000 s[backtrace_catch] pending, rejected, h raises [000.001]: starting[backtrace_catch] pending, rejected, h raises [000.001]: finished in 0.000 s[backtrace_catch] proxy during callback [000.001]: starting[backtrace_catch] proxy during callback [000.001]: finished in 0.000 s[try_bind] fulfilled [000.001]: starting[try_bind] fulfilled [000.001]: finished in 0.000 s[try_bind] fulfilled, f' raises [000.001]: starting[try_bind] fulfilled, f' raises [000.001]: finished in 0.000 s[try_bind] rejected [000.001]: starting[try_bind] rejected [000.001]: finished in 0.000 s[try_bind] f raises [000.001]: starting[try_bind] f raises [000.001]: finished in 0.000 s[try_bind] rejected, h raises [000.001]: starting[try_bind] rejected, h raises [000.001]: finished in 0.000 s[try_bind] pending [000.001]: starting[try_bind] pending [000.001]: finished in 0.000 s[try_bind] pending, fulfilled [000.001]: starting[try_bind] pending, fulfilled [000.001]: finished in 0.000 s[try_bind] pending, fulfilled, f' raises [000.001]: starting[try_bind] pending, fulfilled, f' raises [000.001]: finished in 0.000 s[try_bind] pending, fulfilled, f' pending [000.001]: starting[try_bind] pending, fulfilled, f' pending [000.001]: finished in 0.000 s[try_bind] pending, rejected [000.001]: starting[try_bind] pending, rejected [000.001]: finished in 0.000 s[try_bind] pending, rejected, h raises [000.001]: starting[try_bind] pending, rejected, h raises [000.001]: finished in 0.000 s[try_bind] pending, rejected, h pending [000.001]: starting[try_bind] pending, rejected, h pending [000.001]: finished in 0.000 s[try_bind] proxy during callback (fulfilled) [000.001]: starting[try_bind] proxy during callback (fulfilled) [000.001]: finished in 0.000 s[try_bind] proxy during callback (rejected) [000.001]: starting[try_bind] proxy during callback (rejected) [000.001]: finished in 0.000 s[backtrace_try_bind] fulfilled [000.001]: starting[backtrace_try_bind] fulfilled [000.001]: finished in 0.000 s[backtrace_try_bind] rejected [000.001]: starting[backtrace_try_bind] rejected [000.001]: finished in 0.000 s[backtrace_try_bind] f raises [000.001]: starting[backtrace_try_bind] f raises [000.001]: finished in 0.000 s[backtrace_try_bind] pending [000.001]: starting[backtrace_try_bind] pending [000.001]: finished in 0.000 s[backtrace_try_bind] pending, fulfilled [000.001]: starting[backtrace_try_bind] pending, fulfilled [000.001]: finished in 0.000 s[backtrace_try_bind] pending, fulfilled, f' raises [000.001]: starting[backtrace_try_bind] pending, fulfilled, f' raises [000.001]: finished in 0.000 s[backtrace_try_bind] pending, rejected [000.001]: starting[backtrace_try_bind] pending, rejected [000.001]: finished in 0.000 s[backtrace_try_bind] pending, rejected, h raises [000.001]: starting[backtrace_try_bind] pending, rejected, h raises [000.001]: finished in 0.000 s[backtrace_try_bind] proxy during callback (fulfilled) [000.001]: starting[backtrace_try_bind] proxy during callback (fulfilled) [000.001]: finished in 0.000 s[backtrace_try_bind] proxy during callback (rejected) [000.001]: starting[backtrace_try_bind] proxy during callback (rejected) [000.001]: finished in 0.000 s[finalize] fulfilled [000.001]: starting[finalize] fulfilled [000.001]: finished in 0.000 s[finalize] fulfilled, f' rejected [000.001]: starting[finalize] fulfilled, f' rejected [000.001]: finished in 0.000 s[finalize] fulfilled, f' raises [000.001]: starting[finalize] fulfilled, f' raises [000.001]: finished in 0.000 s[finalize] rejected [000.001]: starting[finalize] rejected [000.001]: finished in 0.000 s[finalize] rejected, f' rejected [000.001]: starting[finalize] rejected, f' rejected [000.001]: finished in 0.000 s[finalize] rejected, f' raises [000.001]: starting[finalize] rejected, f' raises [000.001]: finished in 0.000 s[finalize] pending [000.001]: starting[finalize] pending [000.001]: finished in 0.000 s[finalize] pending, fulfilled [000.001]: starting[finalize] pending, fulfilled [000.001]: finished in 0.000 s[finalize] pending, fulfilled, f' rejected [000.001]: starting[finalize] pending, fulfilled, f' rejected [000.001]: finished in 0.000 s[finalize] pending, fulfilled, f' raises [000.001]: starting[finalize] pending, fulfilled, f' raises [000.001]: finished in 0.000 s[finalize] pending, fulfilled, f' pending [000.001]: starting[finalize] pending, fulfilled, f' pending [000.001]: finished in 0.000 s[finalize] pending, fulfilled, f' pending, rejected [000.001]: starting[finalize] pending, fulfilled, f' pending, rejected [000.001]: finished in 0.000 s[finalize] pending, rejected [000.001]: starting[finalize] pending, rejected [000.001]: finished in 0.000 s[finalize] pending, rejected, f' rejected [000.001]: starting[finalize] pending, rejected, f' rejected [000.001]: finished in 0.000 s[finalize] pending, rejected, f' raises [000.001]: starting[finalize] pending, rejected, f' raises [000.001]: finished in 0.000 s[finalize] pending, rejected, f' pending [000.001]: starting[finalize] pending, rejected, f' pending [000.001]: finished in 0.000 s[finalize] pending, rejected, f' pending, rejected [000.001]: starting[finalize] pending, rejected, f' pending, rejected [000.001]: finished in 0.000 s[finalize] proxy during callback (fulfilled) [000.001]: starting[finalize] proxy during callback (fulfilled) [000.001]: finished in 0.000 s[finalize] proxy during callback (rejected) [000.001]: starting[finalize] proxy during callback (rejected) [000.001]: finished in 0.000 s[backtrace_finalize] fulfilled [000.001]: starting[backtrace_finalize] fulfilled [000.001]: finished in 0.000 s[backtrace_finalize] fulfilled, f' rejected [000.001]: starting[backtrace_finalize] fulfilled, f' rejected [000.001]: finished in 0.000 s[backtrace_finalize] fulfilled, f' raises [000.001]: starting[backtrace_finalize] fulfilled, f' raises [000.001]: finished in 0.000 s[backtrace_finalize] rejected [000.001]: starting[backtrace_finalize] rejected [000.001]: finished in 0.000 s[backtrace_finalize] rejected, f' rejected [000.001]: starting[backtrace_finalize] rejected, f' rejected [000.001]: finished in 0.000 s[backtrace_finalize] rejected, f' raises [000.001]: starting[backtrace_finalize] rejected, f' raises [000.001]: finished in 0.000 s[backtrace_finalize] pending [000.001]: starting[backtrace_finalize] pending [000.001]: finished in 0.000 s[backtrace_finalize] pending, fulfilled [000.001]: starting[backtrace_finalize] pending, fulfilled [000.001]: finished in 0.000 s[backtrace_finalize] pending, fulfilled, f' rejected [000.001]: starting[backtrace_finalize] pending, fulfilled, f' rejected [000.001]: finished in 0.000 s[backtrace_finalize] pending, fulfilled, f' raises [000.001]: starting[backtrace_finalize] pending, fulfilled, f' raises [000.001]: finished in 0.000 s[backtrace_finalize] pending, rejected [000.001]: starting[backtrace_finalize] pending, rejected [000.001]: finished in 0.000 s[backtrace_finalize] pending, rejected, f' rejected [000.001]: starting[backtrace_finalize] pending, rejected, f' rejected [000.001]: finished in 0.000 s[backtrace_finalize] pending, rejected, f' raises [000.001]: starting[backtrace_finalize] pending, rejected, f' raises [000.001]: finished in 0.000 s[backtrace_finalize] proxy during callback (fulfilled) [000.001]: starting[backtrace_finalize] proxy during callback (fulfilled) [000.001]: finished in 0.000 s[backtrace_finalize] proxy during callback (rejected) [000.001]: starting[backtrace_finalize] proxy during callback (rejected) [000.001]: finished in 0.000 s[on_success] fulfilled [000.001]: starting[on_success] fulfilled [000.002]: finished in 0.000 s[on_success] fulfilled, f raises [000.002]: starting[on_success] fulfilled, f raises [000.002]: finished in 0.000 s[on_success] rejected [000.002]: starting[on_success] rejected [000.002]: finished in 0.000 s[on_success] pending [000.002]: starting[on_success] pending [000.002]: finished in 0.000 s[on_success] pending, fulfilled [000.002]: starting[on_success] pending, fulfilled [000.002]: finished in 0.000 s[on_success] pending, fulfilled, f raises [000.002]: starting[on_success] pending, fulfilled, f raises [000.002]: finished in 0.000 s[on_success] pending, rejected [000.002]: starting[on_success] pending, rejected [000.002]: finished in 0.000 s[on_failure] fulfilled [000.002]: starting[on_failure] fulfilled [000.002]: finished in 0.000 s[on_failure] rejected [000.002]: starting[on_failure] rejected [000.002]: finished in 0.000 s[on_failure] rejected, f raises [000.002]: starting[on_failure] rejected, f raises [000.002]: finished in 0.000 s[on_failure] pending [000.002]: starting[on_failure] pending [000.002]: finished in 0.000 s[on_failure] pending, fulfilled [000.002]: starting[on_failure] pending, fulfilled [000.002]: finished in 0.000 s[on_failure] pending, rejected [000.002]: starting[on_failure] pending, rejected [000.002]: finished in 0.000 s[on_failure] pending, rejected, f raises [000.002]: starting[on_failure] pending, rejected, f raises [000.002]: finished in 0.000 s[on_termination] fulfilled [000.002]: starting[on_termination] fulfilled [000.002]: finished in 0.000 s[on_termination] fulfilled, f raises [000.002]: starting[on_termination] fulfilled, f raises [000.002]: finished in 0.000 s[on_termination] rejected [000.002]: starting[on_termination] rejected [000.002]: finished in 0.000 s[on_termination] rejected, f raises [000.002]: starting[on_termination] rejected, f raises [000.002]: finished in 0.000 s[on_termination] pending [000.002]: starting[on_termination] pending [000.002]: finished in 0.000 s[on_termination] pending, fulfilled [000.002]: starting[on_termination] pending, fulfilled [000.002]: finished in 0.000 s[on_termination] pending, fulfilled, f raises [000.002]: starting[on_termination] pending, fulfilled, f raises [000.002]: finished in 0.000 s[on_termination] pending, rejected [000.002]: starting[on_termination] pending, rejected [000.002]: finished in 0.000 s[on_termination] pending, rejected, f raises [000.002]: starting[on_termination] pending, rejected, f raises [000.002]: finished in 0.000 s[on_any] fulfilled [000.002]: starting[on_any] fulfilled [000.002]: finished in 0.000 s[on_any] fulfilled, f raises [000.002]: starting[on_any] fulfilled, f raises [000.002]: finished in 0.000 s[on_any] rejected [000.002]: starting[on_any] rejected [000.002]: finished in 0.000 s[on_any] rejected, f raises [000.002]: starting[on_any] rejected, f raises [000.002]: finished in 0.000 s[on_any] pending [000.002]: starting[on_any] pending [000.002]: finished in 0.000 s[on_any] pending, fulfilled [000.002]: starting[on_any] pending, fulfilled [000.002]: finished in 0.000 s[on_any] pending, fulfilled, f raises [000.002]: starting[on_any] pending, fulfilled, f raises [000.002]: finished in 0.000 s[on_any] pending, rejected [000.002]: starting[on_any] pending, rejected [000.002]: finished in 0.000 s[on_any] pending, rejected, g raises [000.002]: starting[on_any] pending, rejected, g raises [000.002]: finished in 0.000 s[async] fulfilled [000.002]: starting[async] fulfilled [000.002]: finished in 0.000 s[async] f raises [000.002]: starting[async] f raises [000.002]: finished in 0.000 s[async] rejected [000.002]: starting[async] rejected [000.002]: finished in 0.000 s[async] pending, fulfilled [000.002]: starting[async] pending, fulfilled [000.002]: finished in 0.000 s[async] pending, rejected [000.002]: starting[async] pending, rejected [000.002]: finished in 0.000 s[dont_wait] fulfilled [000.002]: starting[dont_wait] fulfilled [000.002]: finished in 0.000 s[dont_wait] f raises [000.002]: starting[dont_wait] f raises [000.002]: finished in 0.000 s[dont_wait] rejected [000.002]: starting[dont_wait] rejected [000.002]: finished in 0.000 s[dont_wait] pending, fulfilled [000.002]: starting[dont_wait] pending, fulfilled [000.002]: finished in 0.000 s[dont_wait] pending, rejected [000.002]: starting[dont_wait] pending, rejected [000.002]: finished in 0.000 s[ignore_result] fulfilled [000.002]: starting[ignore_result] fulfilled [000.002]: finished in 0.000 s[ignore_result] rejected [000.002]: starting[ignore_result] rejected [000.002]: finished in 0.000 s[ignore_result] pending, fulfilled [000.002]: starting[ignore_result] pending, fulfilled [000.002]: finished in 0.000 s[ignore_result] pending, rejected [000.002]: starting[ignore_result] pending, rejected [000.002]: finished in 0.000 s[join] empty [000.002]: starting[join] empty [000.002]: finished in 0.000 s[join] all fulfilled [000.002]: starting[join] all fulfilled [000.002]: finished in 0.000 s[join] all rejected [000.002]: starting[join] all rejected [000.002]: finished in 0.000 s[join] fulfilled and pending, fulfilled [000.002]: starting[join] fulfilled and pending, fulfilled [000.002]: finished in 0.000 s[join] rejected and pending, fulfilled [000.002]: starting[join] rejected and pending, fulfilled [000.002]: finished in 0.000 s[join] fulfilled and pending, rejected [000.002]: starting[join] fulfilled and pending, rejected [000.002]: finished in 0.000 s[join] rejected and pending, rejected [000.002]: starting[join] rejected and pending, rejected [000.002]: finished in 0.000 s[join] diamond [000.002]: starting[join] diamond [000.002]: finished in 0.000 s[all] empty [000.002]: starting[all] empty [000.002]: finished in 0.000 s[all] all fulfilled (one) [000.002]: starting[all] all fulfilled (one) [000.002]: finished in 0.000 s[all] all fulfilled (two) [000.002]: starting[all] all fulfilled (two) [000.002]: finished in 0.000 s[all] all fulfilled (three) [000.002]: starting[all] all fulfilled (three) [000.002]: finished in 0.000 s[all] all fulfilled (long) [000.002]: starting[all] all fulfilled (long) [000.002]: finished in 0.000 s[all] all rejected [000.002]: starting[all] all rejected [000.002]: finished in 0.000 s[all] fulfilled and pending, fulfilled [000.002]: starting[all] fulfilled and pending, fulfilled [000.002]: finished in 0.000 s[all] pending twice physically equal, fulfilled [000.002]: starting[all] pending twice physically equal, fulfilled [000.002]: finished in 0.000 s[all] pending twice physically equal twice, fulfilled [000.002]: starting[all] pending twice physically equal twice, fulfilled [000.002]: finished in 0.000 s[all] fulfilled and pending and fulfilled, fulfilled [000.002]: starting[all] fulfilled and pending and fulfilled, fulfilled [000.002]: finished in 0.000 s[all] fulfilled and pending, fulfilled (long) [000.002]: starting[all] fulfilled and pending, fulfilled (long) [000.002]: finished in 0.000 s[all] rejected and pending, fulfilled [000.002]: starting[all] rejected and pending, fulfilled [000.002]: finished in 0.000 s[all] fulfilled and pending, rejected [000.002]: starting[all] fulfilled and pending, rejected [000.002]: finished in 0.000 s[all] rejected and pending, rejected [000.002]: starting[all] rejected and pending, rejected [000.002]: finished in 0.000 s[all] diamond [000.002]: starting[all] diamond [000.002]: finished in 0.000 s[both] both fulfilled [000.002]: starting[both] both fulfilled [000.002]: finished in 0.000 s[both] both rejected [000.002]: starting[both] both rejected [000.002]: finished in 0.000 s[both] rejected, fulfilled [000.002]: starting[both] rejected, fulfilled [000.002]: finished in 0.000 s[both] fulfilled, rejected [000.002]: starting[both] fulfilled, rejected [000.002]: finished in 0.000 s[both] both pending [000.002]: starting[both] both pending [000.002]: finished in 0.000 s[both] pending, fulfilled [000.002]: starting[both] pending, fulfilled [000.002]: finished in 0.000 s[both] pending, rejected [000.002]: starting[both] pending, rejected [000.002]: finished in 0.000 s[both] fulfilled, pending [000.002]: starting[both] fulfilled, pending [000.002]: finished in 0.000 s[both] rejected, pending [000.002]: starting[both] rejected, pending [000.002]: finished in 0.000 s[both] pending, fulfilled, then fulfilled [000.002]: starting[both] pending, fulfilled, then fulfilled [000.002]: finished in 0.000 s[both] pending, rejected, then fulfilled [000.002]: starting[both] pending, rejected, then fulfilled [000.002]: finished in 0.000 s[both] pending, fulfilled, then rejected [000.002]: starting[both] pending, fulfilled, then rejected [000.002]: finished in 0.000 s[both] pending, rejected, then rejected [000.002]: starting[both] pending, rejected, then rejected [000.002]: finished in 0.000 s[both] fulfilled, pending, then fulfilled [000.002]: starting[both] fulfilled, pending, then fulfilled [000.002]: finished in 0.000 s[both] rejected, pending, then fulfilled [000.002]: starting[both] rejected, pending, then fulfilled [000.002]: finished in 0.000 s[both] fulfilled, pending, then rejected [000.002]: starting[both] fulfilled, pending, then rejected [000.002]: finished in 0.000 s[both] rejected, pending, then rejected [000.002]: starting[both] rejected, pending, then rejected [000.002]: finished in 0.000 s[both] pending, then first fulfilled [000.002]: starting[both] pending, then first fulfilled [000.002]: finished in 0.000 s[both] pending, then first rejected [000.002]: starting[both] pending, then first rejected [000.002]: finished in 0.000 s[both] pending, then second fulfilled [000.002]: starting[both] pending, then second fulfilled [000.002]: finished in 0.000 s[both] pending, then second rejected [000.002]: starting[both] pending, then second rejected [000.002]: finished in 0.000 s[both] pending, then first fulfilled, then fulfilled [000.002]: starting[both] pending, then first fulfilled, then fulfilled [000.002]: finished in 0.000 s[both] pending, then first fulfilled, then rejected [000.002]: starting[both] pending, then first fulfilled, then rejected [000.002]: finished in 0.000 s[both] pending, then first rejected, then fulfilled [000.002]: starting[both] pending, then first rejected, then fulfilled [000.002]: finished in 0.000 s[both] pending, then first rejected, then rejected [000.002]: starting[both] pending, then first rejected, then rejected [000.003]: finished in 0.000 s[both] pending, then second fulfilled, then fulfilled [000.003]: starting[both] pending, then second fulfilled, then fulfilled [000.003]: finished in 0.000 s[both] pending, then second fulfilled, then rejected [000.003]: starting[both] pending, then second fulfilled, then rejected [000.003]: finished in 0.000 s[both] pending, then second rejected, then fulfilled [000.003]: starting[both] pending, then second rejected, then fulfilled [000.003]: finished in 0.000 s[both] pending, then second rejected, then rejected [000.003]: starting[both] pending, then second rejected, then rejected [000.003]: finished in 0.000 s[both] diamond [000.003]: starting[both] diamond [000.003]: finished in 0.000 s[choose] empty [000.003]: starting[choose] empty [000.003]: finished in 0.000 s[choose] fulfilled [000.003]: starting[choose] fulfilled [000.003]: finished in 0.000 s[choose] rejected [000.003]: starting[choose] rejected [000.003]: finished in 0.000 s[choose] multiple resolved [000.003]: starting[choose] multiple resolved [000.003]: finished in 0.000 s[choose] pending [000.003]: starting[choose] pending [000.003]: finished in 0.000 s[choose] pending, fulfilled [000.003]: starting[choose] pending, fulfilled [000.003]: finished in 0.000 s[choose] diamond [000.003]: starting[choose] diamond [000.003]: finished in 0.000 s[nchoose] empty [000.003]: starting[nchoose] empty [000.003]: finished in 0.000 s[nchoose] all fulfilled [000.003]: starting[nchoose] all fulfilled [000.003]: finished in 0.000 s[nchoose] fulfilled, rejected [000.003]: starting[nchoose] fulfilled, rejected [000.003]: finished in 0.000 s[nchoose] rejected, fulfilled [000.003]: starting[nchoose] rejected, fulfilled [000.003]: finished in 0.000 s[nchoose] some pending [000.003]: starting[nchoose] some pending [000.003]: finished in 0.000 s[nchoose] pending, fulfilled [000.003]: starting[nchoose] pending, fulfilled [000.003]: finished in 0.000 s[nchoose] pending, rejected [000.003]: starting[nchoose] pending, rejected [000.003]: finished in 0.000 s[nchoose] diamond [000.003]: starting[nchoose] diamond [000.003]: finished in 0.000 s[nchoose] diamond, rejected [000.003]: starting[nchoose] diamond, rejected [000.003]: finished in 0.000 s[nchoose_split] empty [000.003]: starting[nchoose_split] empty [000.003]: finished in 0.000 s[nchoose_split] some fulfilled [000.003]: starting[nchoose_split] some fulfilled [000.003]: finished in 0.000 s[nchoose_split] fulfilled, rejected [000.003]: starting[nchoose_split] fulfilled, rejected [000.003]: finished in 0.000 s[nchoose_split] rejected, fulfilled [000.003]: starting[nchoose_split] rejected, fulfilled [000.003]: finished in 0.000 s[nchoose_split] pending, rejected [000.003]: starting[nchoose_split] pending, rejected [000.003]: finished in 0.000 s[nchoose_split] pending, fulfilled [000.003]: starting[nchoose_split] pending, fulfilled [000.003]: finished in 0.000 s[nchoose_split] pending, rejected 2 [000.003]: starting[nchoose_split] pending, rejected 2 [000.003]: finished in 0.000 s[nchoose_split] diamond [000.003]: starting[nchoose_split] diamond [000.003]: finished in 0.000 s[nchoose_split] diamond, rejected [000.003]: starting[nchoose_split] diamond, rejected [000.003]: finished in 0.000 s[state query] is_sleeping: fulfilled [000.003]: starting[state query] is_sleeping: fulfilled [000.003]: finished in 0.000 s[state query] is_sleeping: rejected [000.003]: starting[state query] is_sleeping: rejected [000.003]: finished in 0.000 s[state query] is_sleeping: pending [000.003]: starting[state query] is_sleeping: pending [000.003]: finished in 0.000 s[state query] is_sleeping: proxy [000.003]: starting[state query] is_sleeping: proxy [000.003]: finished in 0.000 s[state query] poll: fulfilled [000.003]: starting[state query] poll: fulfilled [000.003]: finished in 0.000 s[state query] poll: rejected [000.003]: starting[state query] poll: rejected [000.003]: finished in 0.000 s[state query] poll: pending [000.003]: starting[state query] poll: pending [000.003]: finished in 0.000 s[state query] poll: proxy [000.003]: starting[state query] poll: proxy [000.003]: finished in 0.000 s[wakeup] wakeup_result: nested [000.003]: starting[wakeup] wakeup_result: nested [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_result: immediate [000.003]: starting[wakeup_later] wakeup_later_result: immediate [000.003]: finished in 0.000 s[wakeup_later] wakeup_later: double use on wait [000.003]: starting[wakeup_later] wakeup_later: double use on wait [000.003]: finished in 0.000 s[wakeup_later] wakeup_later: double use on task [000.003]: starting[wakeup_later] wakeup_later: double use on task [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_result: double use on wait [000.003]: starting[wakeup_later] wakeup_later_result: double use on wait [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_result: double use on task [000.003]: starting[wakeup_later] wakeup_later_result: double use on task [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_exn: double use on wait [000.003]: starting[wakeup_later] wakeup_later_exn: double use on wait [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_exn: double use on task [000.003]: starting[wakeup_later] wakeup_later_exn: double use on task [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_result: nested [000.003]: starting[wakeup_later] wakeup_later_result: nested [000.003]: finished in 0.000 s[wakeup_later] wakeup_later: basic [000.003]: starting[wakeup_later] wakeup_later: basic [000.003]: finished in 0.000 s[wakeup_later] wakeup_later_exn: basic [000.003]: starting[wakeup_later] wakeup_later_exn: basic [000.003]: finished in 0.000 s[cancel] fulfilled [000.003]: starting[cancel] fulfilled [000.003]: finished in 0.000 s[cancel] rejected [000.003]: starting[cancel] rejected [000.003]: finished in 0.000 s[cancel] wait [000.003]: starting[cancel] wait [000.003]: finished in 0.000 s[cancel] task [000.003]: starting[cancel] task [000.003]: finished in 0.000 s[cancel] callback [000.003]: starting[cancel] callback [000.003]: finished in 0.000 s[cancel] nested [000.003]: starting[cancel] nested [000.003]: finished in 0.000 s[on_cancel] pending [000.003]: starting[on_cancel] pending [000.003]: finished in 0.000 s[on_cancel] multiple [000.003]: starting[on_cancel] multiple [000.003]: finished in 0.000 s[on_cancel] ordering [000.003]: starting[on_cancel] ordering [000.003]: finished in 0.000 s[on_cancel] fulfilled [000.003]: starting[on_cancel] fulfilled [000.003]: finished in 0.000 s[on_cancel] rejected [000.003]: starting[on_cancel] rejected [000.003]: finished in 0.000 s[on_cancel] already canceled [000.003]: starting[on_cancel] already canceled [000.003]: finished in 0.000 s[on_cancel] reject with Canceled [000.003]: starting[on_cancel] reject with Canceled [000.003]: finished in 0.000 s[protected] fulfilled [000.003]: starting[protected] fulfilled [000.003]: finished in 0.000 s[protected] rejected [000.003]: starting[protected] rejected [000.003]: finished in 0.000 s[protected] pending [000.003]: starting[protected] pending [000.003]: finished in 0.000 s[protected] pending, fulfilled [000.003]: starting[protected] pending, fulfilled [000.003]: finished in 0.000 s[protected] pending, canceled [000.003]: starting[protected] pending, canceled [000.003]: finished in 0.000 s[protected] pending, canceled, fulfilled [000.003]: starting[protected] pending, canceled, fulfilled [000.003]: finished in 0.000 s[protected] pending, proxy [000.003]: starting[protected] pending, proxy [000.003]: finished in 0.000 s[wrap_in_cancelable] fulfilled [000.003]: starting[wrap_in_cancelable] fulfilled [000.003]: finished in 0.000 s[wrap_in_cancelable] rejected [000.003]: starting[wrap_in_cancelable] rejected [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(task) [000.003]: starting[wrap_in_cancelable] pending(task) [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(task), fulfilled [000.003]: starting[wrap_in_cancelable] pending(task), fulfilled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(task), canceled [000.003]: starting[wrap_in_cancelable] pending(task), canceled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(wait) [000.003]: starting[wrap_in_cancelable] pending(wait) [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(wait), fulfilled [000.003]: starting[wrap_in_cancelable] pending(wait), fulfilled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(wait), canceled [000.003]: starting[wrap_in_cancelable] pending(wait), canceled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(task), canceled, fulfilled [000.003]: starting[wrap_in_cancelable] pending(task), canceled, fulfilled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending(wait), canceled, fulfilled [000.003]: starting[wrap_in_cancelable] pending(wait), canceled, fulfilled [000.003]: finished in 0.000 s[wrap_in_cancelable] pending, proxy [000.003]: starting[wrap_in_cancelable] pending, proxy [000.003]: finished in 0.000 s[no_cancel] fulfilled [000.003]: starting[no_cancel] fulfilled [000.003]: finished in 0.000 s[no_cancel] rejected [000.003]: starting[no_cancel] rejected [000.003]: finished in 0.000 s[no_cancel] pending [000.003]: starting[no_cancel] pending [000.003]: finished in 0.000 s[no_cancel] pending, fulfilled [000.003]: starting[no_cancel] pending, fulfilled [000.003]: finished in 0.000 s[no_cancel] pending, cancel attempt [000.003]: starting[no_cancel] pending, cancel attempt [000.003]: finished in 0.000 s[resolve canceled] wakeup: canceled [000.003]: starting[resolve canceled] wakeup: canceled [000.003]: finished in 0.000 s[resolve canceled] wakeup_later: canceled [000.003]: starting[resolve canceled] wakeup_later: canceled [000.003]: finished in 0.000 s[pick] empty [000.003]: starting[pick] empty [000.003]: finished in 0.000 s[pick] fulfilled [000.003]: starting[pick] fulfilled [000.003]: finished in 0.000 s[pick] rejected [000.003]: starting[pick] rejected [000.003]: finished in 0.000 s[pick] multiple resolved [000.003]: starting[pick] multiple resolved [000.003]: finished in 0.000 s[pick] pending [000.003]: starting[pick] pending [000.003]: finished in 0.000 s[pick] pending, fulfilled [000.004]: starting[pick] pending, fulfilled [000.004]: finished in 0.000 s[pick] diamond [000.004]: starting[pick] diamond [000.004]: finished in 0.000 s[pick] pending, canceled [000.004]: starting[pick] pending, canceled [000.004]: finished in 0.000 s[pick] cancellation/resolution order [000.004]: starting[pick] cancellation/resolution order [000.004]: finished in 0.000 s[npick] empty [000.004]: starting[npick] empty [000.004]: finished in 0.000 s[npick] all fulfilled [000.004]: starting[npick] all fulfilled [000.004]: finished in 0.000 s[npick] fulfilled, rejected [000.004]: starting[npick] fulfilled, rejected [000.004]: finished in 0.000 s[npick] rejected, fulfilled [000.004]: starting[npick] rejected, fulfilled [000.004]: finished in 0.000 s[npick] some pending [000.004]: starting[npick] some pending [000.004]: finished in 0.000 s[npick] pending [000.004]: starting[npick] pending [000.004]: finished in 0.000 s[npick] pending, fulfilled [000.004]: starting[npick] pending, fulfilled [000.004]: finished in 0.000 s[npick] pending, rejected [000.004]: starting[npick] pending, rejected [000.004]: finished in 0.000 s[npick] diamond [000.004]: starting[npick] diamond [000.004]: finished in 0.000 s[npick] diamond, rejected [000.004]: starting[npick] diamond, rejected [000.004]: finished in 0.000 s[npick] pending, canceled [000.004]: starting[npick] pending, canceled [000.004]: finished in 0.000 s[npick] cancellation/resolution order [000.004]: starting[npick] cancellation/resolution order [000.004]: finished in 0.000 s[cancel bind] wait, pending, canceled [000.004]: starting[cancel bind] wait, pending, canceled [000.004]: finished in 0.000 s[cancel bind] task, pending, canceled [000.004]: starting[cancel bind] task, pending, canceled [000.004]: finished in 0.000 s[cancel bind] pending, wait, canceled [000.004]: starting[cancel bind] pending, wait, canceled [000.004]: finished in 0.000 s[cancel bind] pending, task, canceled [000.004]: starting[cancel bind] pending, task, canceled [000.004]: finished in 0.000 s[cancel bind] pending, task, canceled, chain [000.004]: starting[cancel bind] pending, task, canceled, chain [000.004]: finished in 0.000 s[cancel bind] pending, on_cancel callbacks [000.004]: starting[cancel bind] pending, on_cancel callbacks [000.004]: finished in 0.000 s[cancel bind] pending, fulfilled, on_cancel callbacks [000.004]: starting[cancel bind] pending, fulfilled, on_cancel callbacks [000.004]: finished in 0.000 s[cancel map] wait, pending, canceled [000.004]: starting[cancel map] wait, pending, canceled [000.004]: finished in 0.000 s[cancel map] task, pending, canceled [000.004]: starting[cancel map] task, pending, canceled [000.004]: finished in 0.000 s[cancel catch] wait, pending, canceled [000.004]: starting[cancel catch] wait, pending, canceled [000.004]: finished in 0.000 s[cancel catch] task, pending, canceled [000.004]: starting[cancel catch] task, pending, canceled [000.004]: finished in 0.000 s[cancel catch] task, pending, canceled, on_cancel, intercepted [000.004]: starting[cancel catch] task, pending, canceled, on_cancel, intercepted [000.004]: finished in 0.000 s[cancel catch] task, pending, canceled, on_cancel, forwarded [000.004]: starting[cancel catch] task, pending, canceled, on_cancel, forwarded [000.004]: finished in 0.000 s[cancel catch] pending, wait, canceled [000.004]: starting[cancel catch] pending, wait, canceled [000.004]: finished in 0.000 s[cancel catch] pending, task, canceled [000.004]: starting[cancel catch] pending, task, canceled [000.004]: finished in 0.000 s[cancel try_bind] wait, pending, canceled [000.004]: starting[cancel try_bind] wait, pending, canceled [000.004]: finished in 0.000 s[cancel try_bind] task, pending, canceled [000.004]: starting[cancel try_bind] task, pending, canceled [000.004]: finished in 0.000 s[cancel try_bind] pending, fulfilled, wait, canceled [000.004]: starting[cancel try_bind] pending, fulfilled, wait, canceled [000.004]: finished in 0.000 s[cancel try_bind] pending, fulfilled, task, canceled [000.004]: starting[cancel try_bind] pending, fulfilled, task, canceled [000.004]: finished in 0.000 s[cancel try_bind] pending, rejected, wait, canceled [000.004]: starting[cancel try_bind] pending, rejected, wait, canceled [000.004]: finished in 0.000 s[cancel try_bind] pending, rejected, task, canceled [000.004]: starting[cancel try_bind] pending, rejected, task, canceled [000.004]: finished in 0.000 s[cancel finalize] wait, pending, canceled [000.004]: starting[cancel finalize] wait, pending, canceled [000.004]: finished in 0.000 s[cancel finalize] task, pending, canceled [000.004]: starting[cancel finalize] task, pending, canceled [000.004]: finished in 0.000 s[cancel finalize] task, canceled, cancel exception replaced [000.004]: starting[cancel finalize] task, canceled, cancel exception replaced [000.004]: finished in 0.000 s[cancel finalize] pending, wait, canceled [000.004]: starting[cancel finalize] pending, wait, canceled [000.004]: finished in 0.000 s[cancel finalize] pending, task, canceled [000.004]: starting[cancel finalize] pending, task, canceled [000.004]: finished in 0.000 s[cancel with direct handler] on_success: pending, canceled [000.004]: starting[cancel with direct handler] on_success: pending, canceled [000.004]: finished in 0.000 s[cancel with direct handler] on_failure: pending, canceled [000.004]: starting[cancel with direct handler] on_failure: pending, canceled [000.004]: finished in 0.000 s[cancel with direct handler] on_termination: pending, canceled [000.004]: starting[cancel with direct handler] on_termination: pending, canceled [000.004]: finished in 0.000 s[cancel with direct handler] on_any: pending, canceled [000.004]: starting[cancel with direct handler] on_any: pending, canceled [000.004]: finished in 0.000 s[cancel join] wait, pending, cancel [000.004]: starting[cancel join] wait, pending, cancel [000.004]: finished in 0.000 s[cancel join] task, pending, cancel [000.004]: starting[cancel join] task, pending, cancel [000.004]: finished in 0.000 s[cancel join] wait and task, pending, cancel [000.004]: starting[cancel join] wait and task, pending, cancel [000.004]: finished in 0.000 s[cancel join] cancel diamond [000.004]: starting[cancel join] cancel diamond [000.004]: finished in 0.000 s[cancel choose] wait, pending, cancel [000.004]: starting[cancel choose] wait, pending, cancel [000.004]: finished in 0.000 s[cancel choose] wait and task, pending, cancel [000.004]: starting[cancel choose] wait and task, pending, cancel [000.004]: finished in 0.000 s[cancel pick] wait, pending, cancel [000.004]: starting[cancel pick] wait, pending, cancel [000.004]: finished in 0.000 s[cancel pick] wait and task, pending, cancel [000.004]: starting[cancel pick] wait and task, pending, cancel [000.004]: finished in 0.000 s[cancel nchoose] wait, pending, cancel [000.004]: starting[cancel nchoose] wait, pending, cancel [000.004]: finished in 0.000 s[cancel nchoose] wait and task, pending, cancel [000.004]: starting[cancel nchoose] wait and task, pending, cancel [000.004]: finished in 0.000 s[cancel npick] wait, pending, cancel [000.004]: starting[cancel npick] wait, pending, cancel [000.004]: finished in 0.000 s[cancel npick] wait and task, pending, cancel [000.004]: starting[cancel npick] wait and task, pending, cancel [000.004]: finished in 0.000 s[cancel nchoose_split] wait, pending, cancel [000.004]: starting[cancel nchoose_split] wait, pending, cancel [000.004]: finished in 0.000 s[cancel nchoose_split] wait and task, pending, cancel [000.004]: starting[cancel nchoose_split] wait and task, pending, cancel [000.004]: finished in 0.000 s[storage] initial [000.004]: starting[storage] initial [000.004]: finished in 0.000 s[storage] store, retrieve [000.004]: starting[storage] store, retrieve [000.004]: finished in 0.000 s[storage] store, restore [000.004]: starting[storage] store, restore [000.004]: finished in 0.000 s[storage] store, f raises, restore [000.004]: starting[storage] store, f raises, restore [000.004]: finished in 0.000 s[storage] store, overwrite, retrieve [000.004]: starting[storage] store, overwrite, retrieve [000.004]: finished in 0.000 s[storage] store, blank, retrieve [000.004]: starting[storage] store, blank, retrieve [000.004]: finished in 0.000 s[storage] distinct keys [000.004]: starting[storage] distinct keys [000.004]: finished in 0.000 s[storage] bind [000.004]: starting[storage] bind [000.004]: finished in 0.000 s[storage] map [000.004]: starting[storage] map [000.004]: finished in 0.000 s[storage] catch [000.004]: starting[storage] catch [000.004]: finished in 0.000 s[storage] try_bind, fulfilled [000.004]: starting[storage] try_bind, fulfilled [000.004]: finished in 0.000 s[storage] try_bind, rejected [000.004]: starting[storage] try_bind, rejected [000.004]: finished in 0.000 s[storage] finalize [000.004]: starting[storage] finalize [000.004]: finished in 0.000 s[storage] on_success [000.004]: starting[storage] on_success [000.004]: finished in 0.000 s[storage] on_failure [000.004]: starting[storage] on_failure [000.004]: finished in 0.000 s[storage] on_termination, fulfilled [000.004]: starting[storage] on_termination, fulfilled [000.004]: finished in 0.000 s[storage] on_termination, rejected [000.004]: starting[storage] on_termination, rejected [000.004]: finished in 0.000 s[storage] on_any, fulfilled [000.004]: starting[storage] on_any, fulfilled [000.004]: finished in 0.000 s[storage] on_any, rejected [000.004]: starting[storage] on_any, rejected [000.004]: finished in 0.000 s[storage] on_cancel [000.004]: starting[storage] on_cancel [000.004]: finished in 0.000 s[infix operators] >>= [000.004]: starting[infix operators] >>= [000.004]: finished in 0.000 s[infix operators] =<< [000.004]: starting[infix operators] =<< [000.004]: finished in 0.000 s[infix operators] >|= [000.004]: starting[infix operators] >|= [000.004]: finished in 0.000 s[infix operators] =|< [000.004]: starting[infix operators] =|< [000.004]: finished in 0.000 s[infix operators] <&> [000.004]: starting[infix operators] <&> [000.004]: finished in 0.000 s[infix operators] <?> [000.004]: starting[infix operators] <?> [000.004]: finished in 0.000 s[ppx_let] return [000.004]: starting[ppx_let] return [000.004]: finished in 0.000 s[ppx_let] map [000.004]: starting[ppx_let] map [000.004]: finished in 0.000 s[ppx_let] bind [000.004]: starting[ppx_let] bind [000.004]: finished in 0.000 s[ppx_let] both [000.004]: starting[ppx_let] both [000.004]: finished in 0.000 s[ppx_let] Open_on_rhs [000.004]: starting[ppx_let] Open_on_rhs [000.004]: finished in 0.000 s[let syntax] let* [000.004]: starting[let syntax] let* [000.004]: finished in 0.000 s[let syntax] and* [000.004]: starting[let syntax] and* [000.004]: finished in 0.000 s[let syntax] let+/and+ [000.004]: starting[let syntax] let+/and+ [000.004]: finished in 0.000 s[add_task_l and add_task_r] add_task_r [000.004]: starting[add_task_l and add_task_r] add_task_r [000.004]: finished in 0.000 s[add_task_l and add_task_r] add_task_l [000.004]: starting[add_task_l and add_task_r] add_task_l [000.004]: finished in 0.000 s[pause] initial state [000.004]: starting[pause] initial state [000.004]: finished in 0.000 s[pause] one promise [000.004]: starting[pause] one promise [000.004]: finished in 0.000 s[pause] multiple promises [000.004]: starting[pause] multiple promises [000.004]: finished in 0.000 s[pause] wakeup with no promises [000.004]: starting[pause] wakeup with no promises [000.004]: finished in 0.000 s[pause] pause notifier [000.004]: starting[pause] pause notifier [000.004]: finished in 0.000 s[pause] pause in unpause [000.004]: starting[pause] pause in unpause [000.004]: finished in 0.000 s[pause] recursive pause in notifier [000.004]: starting[pause] recursive pause in notifier [000.004]: finished in 0.000 s[pause] unpause in pause [000.004]: starting[pause] unpause in pause [000.004]: finished in 0.000 s[apply and wrap] apply [000.004]: starting[apply and wrap] apply [000.004]: finished in 0.000 s[apply and wrap] apply: raises [000.004]: starting[apply and wrap] apply: raises [000.004]: finished in 0.000 s[apply and wrap] wrap [000.004]: starting[apply and wrap] wrap [000.004]: finished in 0.000 s[apply and wrap] wrap: raises [000.004]: starting[apply and wrap] wrap: raises [000.004]: finished in 0.000 s[apply and wrap] wrap1 [000.004]: starting[apply and wrap] wrap1 [000.004]: finished in 0.000 s[apply and wrap] wrap1: raises [000.004]: starting[apply and wrap] wrap1: raises [000.004]: finished in 0.000 s[apply and wrap] wrap2 [000.004]: starting[apply and wrap] wrap2 [000.004]: finished in 0.000 s[apply and wrap] wrap2: raises [000.004]: starting[apply and wrap] wrap2: raises [000.004]: finished in 0.000 s[apply and wrap] wrap3 [000.004]: starting[apply and wrap] wrap3 [000.004]: finished in 0.000 s[apply and wrap] wrap3: raises [000.004]: starting[apply and wrap] wrap3: raises [000.004]: finished in 0.000 s[apply and wrap] wrap4 [000.004]: starting[apply and wrap] wrap4 [000.004]: finished in 0.000 s[apply and wrap] wrap4: raises [000.004]: starting[apply and wrap] wrap4: raises [000.004]: finished in 0.000 s[apply and wrap] wrap5 [000.004]: starting[apply and wrap] wrap5 [000.004]: finished in 0.000 s[apply and wrap] wrap5: raises [000.004]: starting[apply and wrap] wrap5: raises [000.004]: finished in 0.000 s[apply and wrap] wrap6 [000.004]: starting[apply and wrap] wrap6 [000.004]: finished in 0.000 s[apply and wrap] wrap6: raises [000.004]: starting[apply and wrap] wrap6: raises [000.004]: finished in 0.000 s[apply and wrap] wrap7 [000.004]: starting[apply and wrap] wrap7 [000.004]: finished in 0.000 s[apply and wrap] wrap7: raises [000.004]: starting[apply and wrap] wrap7: raises [000.004]: finished in 0.000 s[callback cleanup] choose [000.004]: starting[callback cleanup] choose [000.004]: finished in 0.000 s[callback cleanup] bind [000.004]: starting[callback cleanup] bind [000.004]: finished in 0.000 s[tailrec] tailrec [000.004]: starting[tailrec] tailrec [000.115]: finished in 0.111 s[lwt_stream] from [000.115]: starting[lwt_stream] from [000.115]: finished in 0.000 s[lwt_stream] return [000.115]: starting[lwt_stream] return [000.115]: finished in 0.000 s[lwt_stream] return_lwt [000.115]: starting[lwt_stream] return_lwt [000.115]: finished in 0.000 s[lwt_stream] return_lwt_with_pause [000.115]: starting[lwt_stream] return_lwt_with_pause [000.115]: finished in 0.000 s[lwt_stream] return_lwt_with_fail [000.115]: starting[lwt_stream] return_lwt_with_fail [000.115]: finished in 0.000 s[lwt_stream] of_seq [000.115]: starting[lwt_stream] of_seq [000.115]: finished in 0.000 s[lwt_stream] of_lwt_seq [000.115]: starting[lwt_stream] of_lwt_seq [000.115]: finished in 0.000 s[lwt_stream] of_list [000.115]: starting[lwt_stream] of_list [000.115]: finished in 0.000 s[lwt_stream] clone [000.115]: starting[lwt_stream] clone [000.115]: finished in 0.000 s[lwt_stream] clone 2 [000.115]: starting[lwt_stream] clone 2 [000.115]: finished in 0.000 s[lwt_stream] create [000.115]: starting[lwt_stream] create [000.115]: finished in 0.000 s[lwt_stream] create 2 [000.115]: starting[lwt_stream] create 2 [000.115]: finished in 0.000 s[lwt_stream] create_bounded [000.115]: starting[lwt_stream] create_bounded [000.115]: finished in 0.000 s[lwt_stream] create_bounded close [000.115]: starting[lwt_stream] create_bounded close [000.115]: finished in 0.000 s[lwt_stream] get_while [000.115]: starting[lwt_stream] get_while [000.115]: finished in 0.000 s[lwt_stream] peek [000.115]: starting[lwt_stream] peek [000.115]: finished in 0.000 s[lwt_stream] npeek [000.115]: starting[lwt_stream] npeek [000.115]: finished in 0.000 s[lwt_stream] get_available [000.115]: starting[lwt_stream] get_available [000.115]: finished in 0.000 s[lwt_stream] get_available_up_to [000.115]: starting[lwt_stream] get_available_up_to [000.115]: finished in 0.000 s[lwt_stream] filter [000.115]: starting[lwt_stream] filter [000.115]: finished in 0.000 s[lwt_stream] filter_map [000.115]: starting[lwt_stream] filter_map [000.115]: finished in 0.000 s[lwt_stream] last_new [000.115]: starting[lwt_stream] last_new [000.115]: finished in 0.000 s[lwt_stream] junk_available [000.115]: starting[lwt_stream] junk_available [000.115]: finished in 0.000 s[lwt_stream] junk_old [000.115]: starting[lwt_stream] junk_old [000.115]: finished in 0.000 s[lwt_stream] cancel push stream 1 [000.115]: starting[lwt_stream] cancel push stream 1 [000.115]: finished in 0.000 s[lwt_stream] cancel push stream 2 [000.115]: starting[lwt_stream] cancel push stream 2 [000.115]: finished in 0.000 s[lwt_stream] cancel push stream 3 [000.115]: starting[lwt_stream] cancel push stream 3 [000.115]: finished in 0.000 s[lwt_stream] push and GC [000.115]: starting[lwt_stream] push and GC [000.116]: finished in 0.001 s[lwt_stream] map_exn [000.116]: starting[lwt_stream] map_exn [000.116]: finished in 0.000 s[lwt_stream] is_closed [000.116]: starting[lwt_stream] is_closed [000.116]: finished in 0.000 s[lwt_stream] closed(bind) [000.116]: starting[lwt_stream] closed(bind) [000.116]: finished in 0.000 s[lwt_stream] closed(on_termination) [000.116]: starting[lwt_stream] closed(on_termination) [000.116]: finished in 0.000 s[lwt_stream] closed when closed [000.116]: starting[lwt_stream] closed when closed [000.116]: finished in 0.000 s[lwt_stream] choose_exhausted [000.116]: starting[lwt_stream] choose_exhausted [000.116]: finished in 0.000 s[lwt_stream] exception passing: basic, from [000.116]: starting[lwt_stream] exception passing: basic, from [000.116]: finished in 0.000 s[lwt_stream] exception passing: basic, from_direct [000.116]: starting[lwt_stream] exception passing: basic, from_direct [000.116]: finished in 0.000 s[lwt_stream] exception passing: to_list [000.116]: starting[lwt_stream] exception passing: to_list [000.116]: finished in 0.000 s[lwt_stream] exception passing: mapped [000.116]: starting[lwt_stream] exception passing: mapped [000.116]: finished in 0.000 s[lwt_stream] exception passing: resume, not closed, from [000.116]: starting[lwt_stream] exception passing: resume, not closed, from [000.116]: finished in 0.000 s[lwt_stream] exception passing: resume, not closed, from_direct [000.116]: starting[lwt_stream] exception passing: resume, not closed, from_direct [000.116]: finished in 0.000 s[lwt_list] iter_p [000.116]: starting[lwt_list] iter_p [000.116]: finished in 0.000 s[lwt_list] iter_s [000.116]: starting[lwt_list] iter_s [000.116]: finished in 0.000 s[lwt_list] map_p [000.116]: starting[lwt_list] map_p [000.116]: finished in 0.000 s[lwt_list] map_s [000.116]: starting[lwt_list] map_s [000.116]: finished in 0.000 s[lwt_list] fold_left_s [000.116]: starting[lwt_list] fold_left_s [000.116]: finished in 0.000 s[lwt_list] for_all_s [000.116]: starting[lwt_list] for_all_s [000.116]: finished in 0.000 s[lwt_list] for_all_p [000.116]: starting[lwt_list] for_all_p [000.116]: finished in 0.000 s[lwt_list] exists_s true [000.116]: starting[lwt_list] exists_s true [000.116]: finished in 0.000 s[lwt_list] exists_p true [000.116]: starting[lwt_list] exists_p true [000.116]: finished in 0.000 s[lwt_list] exists_s false [000.116]: starting[lwt_list] exists_s false [000.116]: finished in 0.000 s[lwt_list] exists_p false [000.116]: starting[lwt_list] exists_p false [000.116]: finished in 0.000 s[lwt_list] filter_s [000.116]: starting[lwt_list] filter_s [000.116]: finished in 0.000 s[lwt_list] filter_p [000.116]: starting[lwt_list] filter_p [000.116]: finished in 0.000 s[lwt_list] partition_p [000.116]: starting[lwt_list] partition_p [000.116]: finished in 0.000 s[lwt_list] partition_s [000.116]: starting[lwt_list] partition_s [000.116]: finished in 0.000 s[lwt_list] filter_map_p [000.116]: starting[lwt_list] filter_map_p [000.116]: finished in 0.000 s[lwt_list] filter_map_s [000.116]: starting[lwt_list] filter_map_s [000.116]: finished in 0.000 s[lwt_list] iteri_p [000.116]: starting[lwt_list] iteri_p [000.116]: finished in 0.000 s[lwt_list] iteri_s [000.116]: starting[lwt_list] iteri_s [000.116]: finished in 0.000 s[lwt_list] mapi_p [000.116]: starting[lwt_list] mapi_p [000.116]: finished in 0.000 s[lwt_list] mapi_s [000.116]: starting[lwt_list] mapi_s [000.116]: finished in 0.000 s[lwt_list] find_s existing [000.116]: starting[lwt_list] find_s existing [000.116]: finished in 0.000 s[lwt_list] find_s missing [000.116]: starting[lwt_list] find_s missing [000.116]: finished in 0.000 s[lwt_list] rev_map_p [000.116]: starting[lwt_list] rev_map_p [000.116]: finished in 0.000 s[lwt_list] rev_map_s [000.116]: starting[lwt_list] rev_map_s [000.117]: finished in 0.000 s[lwt_list] fold_right_s [000.117]: starting[lwt_list] fold_right_s [000.117]: finished in 0.000 s[lwt_list] iteri_p exception [000.117]: starting[lwt_list] iteri_p exception [000.117]: finished in 0.000 s[lwt_list] iteri_s exception [000.117]: starting[lwt_list] iteri_s exception [000.117]: finished in 0.000 s[lwt_list] map_s exception [000.117]: starting[lwt_list] map_s exception [000.117]: finished in 0.000 s[lwt_list] map_p exception [000.117]: starting[lwt_list] map_p exception [000.117]: finished in 0.000 s[lwt_list] mapi_s exception [000.117]: starting[lwt_list] mapi_s exception [000.117]: finished in 0.000 s[lwt_list] mapi_p exception [000.117]: starting[lwt_list] mapi_p exception [000.117]: finished in 0.000 s[lwt_list] rev_map_s exception [000.117]: starting[lwt_list] rev_map_s exception [000.117]: finished in 0.000 s[lwt_list] rev_map_p exception [000.117]: starting[lwt_list] rev_map_p exception [000.117]: finished in 0.000 s[lwt_list] fold_left_s exception [000.117]: starting[lwt_list] fold_left_s exception [000.117]: finished in 0.000 s[lwt_list] fold_right_s exception [000.117]: starting[lwt_list] fold_right_s exception [000.117]: finished in 0.000 s[lwt_list] for_all_p exception [000.117]: starting[lwt_list] for_all_p exception [000.117]: finished in 0.000 s[lwt_list] for_all_s exception [000.117]: starting[lwt_list] for_all_s exception [000.117]: finished in 0.000 s[lwt_list] exists_p exception [000.117]: starting[lwt_list] exists_p exception [000.117]: finished in 0.000 s[lwt_list] exists_s exception [000.117]: starting[lwt_list] exists_s exception [000.117]: finished in 0.000 s[lwt_list] find_s exception [000.117]: starting[lwt_list] find_s exception [000.117]: finished in 0.000 s[lwt_list] filter_p exception [000.117]: starting[lwt_list] filter_p exception [000.117]: finished in 0.000 s[lwt_list] filter_s exception [000.117]: starting[lwt_list] filter_s exception [000.117]: finished in 0.000 s[lwt_list] filter_map_p exception [000.117]: starting[lwt_list] filter_map_p exception [000.117]: finished in 0.000 s[lwt_list] filter_map_s exception [000.117]: starting[lwt_list] filter_map_s exception [000.117]: finished in 0.000 s[lwt_list] partition_p exception [000.117]: starting[lwt_list] partition_p exception [000.117]: finished in 0.000 s[lwt_list] partition_s exception [000.117]: starting[lwt_list] partition_s exception [000.117]: finished in 0.000 s[lwt_list] iter_p parallelism [000.117]: starting[lwt_list] iter_p parallelism [000.117]: finished in 0.000 s[lwt_list] iter_s serialization [000.117]: starting[lwt_list] iter_s serialization [000.117]: finished in 0.000 s[lwt_list] iteri_p parallelism [000.117]: starting[lwt_list] iteri_p parallelism [000.117]: finished in 0.000 s[lwt_list] iteri_s serialization [000.117]: starting[lwt_list] iteri_s serialization [000.117]: finished in 0.000 s[lwt_list] map_p parallelism [000.117]: starting[lwt_list] map_p parallelism [000.117]: finished in 0.000 s[lwt_list] map_s serialization [000.117]: starting[lwt_list] map_s serialization [000.117]: finished in 0.000 s[lwt_list] mapi_p parallelism [000.117]: starting[lwt_list] mapi_p parallelism [000.117]: finished in 0.000 s[lwt_list] mapi_s serialization [000.117]: starting[lwt_list] mapi_s serialization [000.117]: finished in 0.000 s[lwt_list] rev_map_p parallelism [000.117]: starting[lwt_list] rev_map_p parallelism [000.117]: finished in 0.000 s[lwt_list] rev_map_s serialization [000.117]: starting[lwt_list] rev_map_s serialization [000.117]: finished in 0.000 s[lwt_list] fold_left_s serialization [000.117]: starting[lwt_list] fold_left_s serialization [000.117]: finished in 0.000 s[lwt_list] fold_right_s serialization [000.117]: starting[lwt_list] fold_right_s serialization [000.117]: finished in 0.000 s[lwt_list] filter_map_p parallelism [000.117]: starting[lwt_list] filter_map_p parallelism [000.117]: finished in 0.000 s[lwt_list] filter_map_s serlialism [000.117]: starting[lwt_list] filter_map_s serlialism [000.117]: finished in 0.000 s[lwt_list] for_all_p parallelism [000.117]: starting[lwt_list] for_all_p parallelism [000.117]: finished in 0.000 s[lwt_list] for_all_s serialization [000.117]: starting[lwt_list] for_all_s serialization [000.117]: finished in 0.000 s[lwt_list] exists_p parallelism [000.117]: starting[lwt_list] exists_p parallelism [000.117]: finished in 0.000 s[lwt_list] exists_s serialization [000.117]: starting[lwt_list] exists_s serialization [000.117]: finished in 0.000 s[lwt_list] find_s serialization [000.117]: starting[lwt_list] find_s serialization [000.117]: finished in 0.000 s[lwt_list] filter_p parallelism [000.117]: starting[lwt_list] filter_p parallelism [000.117]: finished in 0.000 s[lwt_list] filter_s serialization [000.117]: starting[lwt_list] filter_s serialization [000.117]: finished in 0.000 s[lwt_list] filter_map_s serialization [000.117]: starting[lwt_list] filter_map_s serialization [000.117]: finished in 0.000 s[lwt_list] partition_p parallelism [000.117]: starting[lwt_list] partition_p parallelism [000.117]: finished in 0.000 s[lwt_list] partition_s serialization [000.117]: starting[lwt_list] partition_s serialization [000.117]: finished in 0.000 slwt_list big lists [000.117]: skipping[lwt_switch] turn_off, add_hook [000.117]: starting[lwt_switch] turn_off, add_hook [000.117]: finished in 0.000 s[lwt_switch] turn_off: hook exception [000.117]: starting[lwt_switch] turn_off: hook exception [000.117]: finished in 0.000 s[lwt_switch] with_switch: regular exit [000.117]: starting[lwt_switch] with_switch: regular exit [000.117]: finished in 0.000 s[lwt_switch] with_switch: exception [000.117]: starting[lwt_switch] with_switch: exception [000.117]: finished in 0.000 s[lwt_switch] check [000.117]: starting[lwt_switch] check [000.117]: finished in 0.000 s[lwt_switch] is_on [000.117]: starting[lwt_switch] is_on [000.117]: finished in 0.000 s[lwt_switch] add_hook_or_exec [000.117]: starting[lwt_switch] add_hook_or_exec [000.117]: finished in 0.000 s[lwt_switch] turn_off waits for hooks: regular exit [000.117]: starting[lwt_switch] turn_off waits for hooks: regular exit [000.117]: finished in 0.000 s[lwt_switch] turn_off waits for hooks: hook exception [000.117]: starting[lwt_switch] turn_off waits for hooks: hook exception [000.117]: finished in 0.000 s[lwt_mutex] cancel [000.117]: starting[lwt_mutex] cancel [000.117]: finished in 0.000 s[lwt_mutex] cancel while queued by unlock [000.117]: starting[lwt_mutex] cancel while queued by unlock [000.117]: finished in 0.000 s[lwt_result] maps [000.117]: starting[lwt_result] maps [000.117]: finished in 0.000 s[lwt_result] >|= is a variant of map [000.117]: starting[lwt_result] >|= is a variant of map [000.117]: finished in 0.000 s[lwt_result] map, error case [000.117]: starting[lwt_result] map, error case [000.117]: finished in 0.000 s[lwt_result] map_error [000.117]: starting[lwt_result] map_error [000.117]: finished in 0.000 s[lwt_result] map_error, error case [000.117]: starting[lwt_result] map_error, error case [000.117]: finished in 0.000 s[lwt_result] bind [000.117]: starting[lwt_result] bind [000.117]: finished in 0.000 s[lwt_result] bind, error case [000.117]: starting[lwt_result] bind, error case [000.117]: finished in 0.000 s[lwt_result] bind_error [000.117]: starting[lwt_result] bind_error [000.117]: finished in 0.000 s[lwt_result] bind_error, error case [000.117]: starting[lwt_result] bind_error, error case [000.117]: finished in 0.000 s[lwt_result] ok [000.117]: starting[lwt_result] ok [000.117]: finished in 0.000 s[lwt_result] error [000.117]: starting[lwt_result] error [000.117]: finished in 0.000 s[lwt_result] catch [000.117]: starting[lwt_result] catch [000.117]: finished in 0.000 s[lwt_result] catch, error case [000.117]: starting[lwt_result] catch, error case [000.117]: finished in 0.000 s[lwt_result] catch, bound raise [000.117]: starting[lwt_result] catch, bound raise [000.117]: finished in 0.000 s[lwt_result] catch, immediate raise [000.117]: starting[lwt_result] catch, immediate raise [000.117]: finished in 0.000 s[lwt_result] get_exn [000.117]: starting[lwt_result] get_exn [000.117]: finished in 0.000 s[lwt_result] get_exn, error case [000.117]: starting[lwt_result] get_exn, error case [000.117]: finished in 0.000 s[lwt_result] bind_lwt [000.117]: starting[lwt_result] bind_lwt [000.117]: finished in 0.000 s[lwt_result] bind_lwt, error case [000.117]: starting[lwt_result] bind_lwt, error case [000.117]: finished in 0.000 s[lwt_result] bind_lwt_error [000.117]: starting[lwt_result] bind_lwt_error [000.117]: finished in 0.000 s[lwt_result] bind_lwt_error, error case [000.117]: starting[lwt_result] bind_lwt_error, error case [000.117]: finished in 0.000 s[lwt_result] bind_result [000.117]: starting[lwt_result] bind_result [000.117]: finished in 0.000 s[lwt_result] bind_result, error case [000.117]: starting[lwt_result] bind_result, error case [000.117]: finished in 0.000 s[lwt_result] both ok [000.117]: starting[lwt_result] both ok [000.117]: finished in 0.000 s[lwt_result] both only fst error [000.117]: starting[lwt_result] both only fst error [000.117]: finished in 0.000 s[lwt_result] both only snd error [000.117]: starting[lwt_result] both only snd error [000.117]: finished in 0.000 s[lwt_result] both error, fst [000.117]: starting[lwt_result] both error, fst [000.117]: finished in 0.000 s[lwt_result] both error, snd [000.117]: starting[lwt_result] both error, snd [000.117]: finished in 0.000 s[lwt_result] iter [000.117]: starting[lwt_result] iter [000.117]: finished in 0.000 s[lwt_result] iter, error case [000.117]: starting[lwt_result] iter, error case [000.117]: finished in 0.000 s[lwt_result] iter_error [000.117]: starting[lwt_result] iter_error [000.117]: finished in 0.000 s[lwt_result] iter_error, success case [000.117]: starting[lwt_result] iter_error, success case [000.117]: finished in 0.000 s[lwt_result] let* [000.117]: starting[lwt_result] let* [000.117]: finished in 0.000 s[lwt_result] and* [000.117]: starting[lwt_result] and* [000.117]: finished in 0.000 s[lwt_result] let+/and+ [000.117]: starting[lwt_result] let+/and+ [000.117]: finished in 0.000 s[lwt_mvar] basic take [000.117]: starting[lwt_mvar] basic take [000.117]: finished in 0.000 s[lwt_mvar] take_available (full) [000.117]: starting[lwt_mvar] take_available (full) [000.117]: finished in 0.000 s[lwt_mvar] take_available (empty) [000.117]: starting[lwt_mvar] take_available (empty) [000.117]: finished in 0.000 s[lwt_mvar] take_available (twice) [000.117]: starting[lwt_mvar] take_available (twice) [000.117]: finished in 0.000 s[lwt_mvar] is_empty (full) [000.117]: starting[lwt_mvar] is_empty (full) [000.117]: finished in 0.000 s[lwt_mvar] is_empty (empty) [000.117]: starting[lwt_mvar] is_empty (empty) [000.117]: finished in 0.000 s[lwt_mvar] blocking put [000.117]: starting[lwt_mvar] blocking put [000.117]: finished in 0.000 s[lwt_mvar] put-take [000.117]: starting[lwt_mvar] put-take [000.117]: finished in 0.000 s[lwt_mvar] take-put [000.117]: starting[lwt_mvar] take-put [000.117]: finished in 0.000 s[lwt_mvar] enqueued writer [000.117]: starting[lwt_mvar] enqueued writer [000.117]: finished in 0.000 s[lwt_mvar] writer cancellation [000.117]: starting[lwt_mvar] writer cancellation [000.117]: finished in 0.000 s[lwt_condition] basic wait [000.117]: starting[lwt_condition] basic wait [000.117]: finished in 0.000 s[lwt_condition] mutex unlocked during wait [000.117]: starting[lwt_condition] mutex unlocked during wait [000.117]: finished in 0.000 s[lwt_condition] mutex relocked after wait [000.117]: starting[lwt_condition] mutex relocked after wait [000.117]: finished in 0.000 s[lwt_condition] signal is not sticky [000.117]: starting[lwt_condition] signal is not sticky [000.117]: finished in 0.000 s[lwt_condition] broadcast [000.117]: starting[lwt_condition] broadcast [000.117]: finished in 0.000 s[lwt_condition] broadcast exception [000.117]: starting[lwt_condition] broadcast exception [000.117]: finished in 0.000 s[lwt_pool] basic create-use [000.117]: starting[lwt_pool] basic create-use [000.117]: finished in 0.000 s[lwt_pool] creator exception [000.117]: starting[lwt_pool] creator exception [000.117]: finished in 0.000 s[lwt_pool] pool elements are reused [000.117]: starting[lwt_pool] pool elements are reused [000.117]: finished in 0.000 s[lwt_pool] pool elements are validated when returned [000.117]: starting[lwt_pool] pool elements are validated when returned [000.117]: finished in 0.000 s[lwt_pool] validation exceptions are propagated to users [000.117]: starting[lwt_pool] validation exceptions are propagated to users [000.117]: finished in 0.000 s[lwt_pool] multiple creation [000.117]: starting[lwt_pool] multiple creation [000.117]: finished in 0.000 s[lwt_pool] users of an empty pool will wait [000.117]: starting[lwt_pool] users of an empty pool will wait [000.117]: finished in 0.000 s[lwt_pool] on check, good elements are retained [000.117]: starting[lwt_pool] on check, good elements are retained [000.117]: finished in 0.000 s[lwt_pool] on check, bad elements are disposed of and replaced [000.117]: starting[lwt_pool] on check, bad elements are disposed of and replaced [000.117]: finished in 0.000 s[lwt_pool] clear disposes of all elements [000.117]: starting[lwt_pool] clear disposes of all elements [000.117]: finished in 0.000 s[lwt_pool] waiter are notified on replacement [000.117]: starting[lwt_pool] waiter are notified on replacement [000.117]: finished in 0.000 s[lwt_pool] waiter are notified on replacement exception [000.117]: starting[lwt_pool] waiter are notified on replacement exception [000.117]: finished in 0.000 s[lwt_pool] check and validate can be used together [000.117]: starting[lwt_pool] check and validate can be used together [000.117]: finished in 0.000 s[lwt_pool] verify default check behavior [000.117]: starting[lwt_pool] verify default check behavior [000.118]: finished in 0.000 s[lwt_sequence] create [000.118]: starting[lwt_sequence] create [000.118]: finished in 0.000 s[lwt_sequence] add_l [000.118]: starting[lwt_sequence] add_l [000.118]: finished in 0.000 s[lwt_sequence] add_r [000.118]: starting[lwt_sequence] add_r [000.118]: finished in 0.000 s[lwt_sequence] take_l Empty [000.118]: starting[lwt_sequence] take_l Empty [000.118]: finished in 0.000 s[lwt_sequence] take_l [000.118]: starting[lwt_sequence] take_l [000.118]: finished in 0.000 s[lwt_sequence] take_r Empty [000.118]: starting[lwt_sequence] take_r Empty [000.118]: finished in 0.000 s[lwt_sequence] take_r [000.118]: starting[lwt_sequence] take_r [000.118]: finished in 0.000 s[lwt_sequence] take_opt_l Empty [000.118]: starting[lwt_sequence] take_opt_l Empty [000.118]: finished in 0.000 s[lwt_sequence] take_opt_l [000.118]: starting[lwt_sequence] take_opt_l [000.118]: finished in 0.000 s[lwt_sequence] take_opt_r Empty [000.118]: starting[lwt_sequence] take_opt_r Empty [000.118]: finished in 0.000 s[lwt_sequence] take_opt_r [000.118]: starting[lwt_sequence] take_opt_r [000.118]: finished in 0.000 s[lwt_sequence] transfer_l Empty [000.118]: starting[lwt_sequence] transfer_l Empty [000.118]: finished in 0.000 s[lwt_sequence] transfer_l [000.118]: starting[lwt_sequence] transfer_l [000.118]: finished in 0.000 s[lwt_sequence] transfer_r Empty [000.118]: starting[lwt_sequence] transfer_r Empty [000.118]: finished in 0.000 s[lwt_sequence] transfer_r [000.118]: starting[lwt_sequence] transfer_r [000.118]: finished in 0.000 s[lwt_sequence] iter_l Empty [000.118]: startinglwt_sequence] iter_l Empty [000.118]: finished in 0.000 s[lwt_sequence] iter_l [000.118]: starting[lwt_sequence] iter_l [000.118]: finished in 0.000 s[lwt_sequence] iter_r Empty [000.118]: starting[lwt_sequence] iter_r Empty [000.118]: finished in 0.000 s[lwt_sequence] iter_r [000.118]: starting[lwt_sequence] iter_r [000.118]: finished in 0.000 s[lwt_sequence] iter_node_l Empty [000.118]: starting[lwt_sequence] iter_node_l Empty [000.118]: finished in 0.000 s[lwt_sequence] iter_node_l [000.118]: starting[lwt_sequence] iter_node_l [000.118]: finished in 0.000 s[lwt_sequence] iter_node_r Empty [000.118]: starting[lwt_sequence] iter_node_r Empty [000.118]: finished in 0.000 s[lwt_sequence] iter_node_r [000.118]: starting[lwt_sequence] iter_node_r [000.118]: finished in 0.000 s[lwt_sequence] iter_node_l with removal [000.118]: starting[lwt_sequence] iter_node_l with removal [000.118]: finished in 0.000 s[lwt_sequence] iter_node_r with removal [000.118]: starting[lwt_sequence] iter_node_r with removal [000.118]: finished in 0.000 s[lwt_sequence] fold_l [000.118]: starting[lwt_sequence] fold_l [000.118]: finished in 0.000 s[lwt_sequence] fold_l Empty [000.118]: starting[lwt_sequence] fold_l Empty [000.118]: finished in 0.000 s[lwt_sequence] fold_r [000.118]: starting[lwt_sequence] fold_r [000.118]: finished in 0.000 s[lwt_sequence] fold_r Empty [000.118]: starting[lwt_sequence] fold_r Empty [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_l Empty [000.118]: starting[lwt_sequence] find_node_opt_l Empty [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_l not found [000.118]: starting[lwt_sequence] find_node_opt_l not found [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_l [000.118]: starting[lwt_sequence] find_node_opt_l [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_r Empty [000.118]: starting[lwt_sequence] find_node_opt_r Empty [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_r not found [000.118]: starting[lwt_sequence] find_node_opt_r not found [000.118]: finished in 0.000 s[lwt_sequence] find_node_opt_r [000.118]: starting[lwt_sequence] find_node_opt_r [000.118]: finished in 0.000 s[lwt_sequence] find_node_l Empty [000.118]: starting[lwt_sequence] find_node_l Empty [000.118]: finished in 0.000 s[lwt_sequence] find_node_l [000.118]: starting[lwt_sequence] find_node_l [000.118]: finished in 0.000 s[lwt_sequence] find_node_r Empty [000.118]: starting[lwt_sequence] find_node_r Empty [000.118]: finished in 0.000 s[lwt_sequence] find_node_r [000.118]: starting[lwt_sequence] find_node_r [000.118]: finished in 0.000 s[lwt_sequence] set [000.118]: starting[lwt_sequence] set [000.118]: finished in 0.000 s[lwt_sequence] fold_r with multiple removal [000.118]: starting[lwt_sequence] fold_r with multiple removal [000.118]: finished in 0.000 s[lwt_sequence] fold_l multiple removal [000.118]: starting[lwt_sequence] fold_l multiple removal [000.118]: finished in 0.000 s[lwt_sequence] find_node_r with multiple removal [000.118]: starting[lwt_sequence] find_node_r with multiple removal [000.118]: finished in 0.000 s[lwt_sequence] find_node_l with multiple removal [000.118]: starting[lwt_sequence] find_node_l with multiple removal [000.118]: finished in 0.000 s[lwt_seq] fold_left [000.118]: starting[lwt_seq] fold_left [000.118]: finished in 0.000 s[lwt_seq] fold_left_s [000.118]: starting[lwt_seq] fold_left_s [000.118]: finished in 0.000 s[lwt_seq] map [000.118]: starting[lwt_seq] map [000.118]: finished in 0.000 s[lwt_seq] map_s [000.118]: starting[lwt_seq] map_s [000.118]: finished in 0.000 s[lwt_seq] filter [000.118]: starting[lwt_seq] filter [000.118]: finished in 0.000 s[lwt_seq] filter_s [000.118]: starting[lwt_seq] filter_s [000.118]: finished in 0.000 s[lwt_seq] iter_n(1) [000.118]: starting[lwt_seq] iter_n(1) [000.118]: finished in 0.000 s[lwt_seq] iter_n(2) [000.118]: starting[lwt_seq] iter_n(2) [000.118]: finished in 0.000 s[lwt_seq] iter_n(100) [000.118]: starting[lwt_seq] iter_n(100) [000.118]: finished in 0.000 s[lwt_seq] filter_map [000.118]: starting[lwt_seq] filter_map [000.118]: finished in 0.000 s[lwt_seq] filter_map_s [000.118]: starting[lwt_seq] filter_map_s [000.118]: finished in 0.000 s[lwt_seq] unfold [000.118]: starting[lwt_seq] unfold [000.118]: finished in 0.000 s[lwt_seq] unfold_lwt [000.118]: starting[lwt_seq] unfold_lwt [000.118]: finished in 0.000 s[lwt_seq] fold-into-exception-from-of-seq [000.118]: starting[lwt_seq] fold-into-exception-from-of-seq [000.118]: finished in 0.000 s[lwt_seq] fold-into-immediate-exception-from-of-seq [000.118]: starting[lwt_seq] fold-into-immediate-exception-from-of-seq [000.118]: finished in 0.000 s[lwt_seq] fold-into-exception-from-of-seq-lwt [000.118]: starting[lwt_seq] fold-into-exception-from-of-seq-lwt [000.118]: finished in 0.000 s[lwt_seq] fold-into-immediate-exception-from-of-seq-lwt [000.118]: starting[lwt_seq] fold-into-immediate-exception-from-of-seq-lwt [000.118]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] map [000.118]: starting[lwt_seq(pseudo-fuzzing)] map [000.118]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] map_s [000.118]: starting[lwt_seq(pseudo-fuzzing)] map_s [000.118]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] iter [000.118]: starting[lwt_seq(pseudo-fuzzing)] iter [000.118]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] iter_s [000.118]: starting[lwt_seq(pseudo-fuzzing)] iter_s [000.118]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] iter_p [000.118]: starting[lwt_seq(pseudo-fuzzing)] iter_p [000.119]: finished in 0.000 s[lwt_seq(pseudo-fuzzing)] iter_p (pause) [000.119]: starting[lwt_seq(pseudo-fuzzing)] iter_p (pause) [000.120]: finished in 0.002 s[lwt_seq(pseudo-fuzzing)] iter_n [000.120]: starting[lwt_seq(pseudo-fuzzing)] iter_n [000.121]: finished in 0.001 s[lwt_seq(pseudo-fuzzing)] iter_n (pause) [000.121]: starting[lwt_seq(pseudo-fuzzing)] iter_n (pause) [000.137]: finished in 0.016 s(cd _build/default/test/ppx && ./main.exe)Testing library 'ppx'......................Ok. 19 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.202]: finished in 0.601 s[ppx] assert [001.202]: starting[ppx] assert [001.202]: finished in 0.000 s[ppx] try [001.202]: starting[ppx] try [001.202]: finished in 0.000 s[ppx] try raise [001.202]: starting[ppx] try raise [001.202]: finished in 0.000 s[ppx] try fallback [001.202]: starting[ppx] try fallback [001.202]: finished in 0.000 s[ppx] finally body [001.202]: starting[ppx] finally body [001.202]: finished in 0.000 s[ppx] finally exn [001.202]: starting[ppx] finally exn [001.202]: finished in 0.000 s[ppx] finally exn default [001.202]: starting[ppx] finally exn default [001.202]: finished in 0.000 s[ppx] structure let [001.202]: starting[ppx] structure let [001.202]: finished in 0.000 s[ppx] 1085-int [001.202]: starting[ppx] 1085-int [001.202]: finished in 0.000 s[ppx] 1085-int-again [001.202]: starting[ppx] 1085-int-again [001.202]: finished in 0.000 s[ppx] 1085-any [001.202]: starting[ppx] 1085-any [001.202]: 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.500 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.501]: finished in 0.000 s[lwt_event] with_finaliser lifetime [002.501]: starting[lwt_event] with_finaliser lifetime [002.501]: finished in 0.001 s[lwt_signal] limit [002.501]: starting[lwt_signal] limit [002.502]: finished in 0.000 s[lwt_signal] limit race condition [002.502]: starting[lwt_signal] limit race condition [004.502]: finished in 2.001 s[lwt_signal] with_finaliser lifetime [004.503]: starting[lwt_signal] with_finaliser lifetime [004.503]: finished in 0.001 s(cd _build/default/test/unix && ./main.exe)Testing library 'unix'................................SSSSS..............................................................................................................SSSS.................................................................................Ok. 220 tests ran, 9 tests skipped in 6.27 seconds[lwt_unix] basic pread blocking [000.000]: starting[lwt_unix] basic pread blocking [000.000]: finished in 0.000 s[lwt_unix] basic pwrite blocking [000.000]: starting[lwt_unix] basic pwrite blocking [000.000]: finished in 0.000 s[lwt_unix] remove file blocking [000.000]: starting[lwt_unix] remove file blocking [000.000]: finished in 0.000 s[lwt_unix] basic pread nonblocking [000.000]: starting[lwt_unix] basic pread nonblocking [000.001]: finished in 0.000 s[lwt_unix] basic pwrite nonblocking [000.001]: starting[lwt_unix] basic pwrite nonblocking [000.001]: finished in 0.000 s[lwt_unix] remove file nonblocking [000.001]: starting[lwt_unix] remove file nonblocking [000.001]: finished in 0.000 s[lwt_unix] dup on socket blocking [000.001]: starting[lwt_unix] dup on socket blocking [000.001]: finished in 0.000 s[lwt_unix] dup on file blocking [000.001]: starting[lwt_unix] dup on file blocking [000.001]: finished in 0.000 s[lwt_unix] dup on socket nonblocking [000.001]: starting[lwt_unix] dup on socket nonblocking [000.001]: finished in 0.000 s[lwt_unix] dup on file nonblocking [000.001]: starting[lwt_unix] dup on file nonblocking [000.001]: finished in 0.000 s[lwt_io] auto-flush [000.001]: starting[lwt_io] auto-flush [000.101]: finished in 0.100 s[lwt_io] auto-flush in atomic [000.101]: starting[lwt_io] auto-flush in atomic [000.201]: finished in 0.100 s[lwt_io] establish_server: implicit close on exception [000.201]: starting[lwt_io] establish_server: implicit close on exception [000.252]: finished in 0.050 s[lwt_io] with_temp_dir [000.252]: starting[lwt_io] with_temp_dir [000.253]: finished in 0.001 s[lwt_io non blocking io] file does not exist [000.253]: starting[lwt_io non blocking io] file does not exist [000.253]: finished in 0.000 s[lwt_io non blocking io] file does not exist (invalid path) [000.253]: starting[lwt_io non blocking io] file does not exist (invalid path) [000.253]: finished in 0.000 s[lwt_io non blocking io] file does not exist (LargeFile) [000.253]: starting[lwt_io non blocking io] file does not exist (LargeFile) [000.253]: finished in 0.000 s[lwt_io non blocking io] file does not exist (LargeFile, invalid path) [000.253]: starting[lwt_io non blocking io] file does not exist (LargeFile, invalid path) [000.253]: finished in 0.000 s[lwt_io non blocking io] create file [000.253]: starting[lwt_io non blocking io] create file [000.253]: finished in 0.000 s[lwt_io non blocking io] file exists [000.253]: starting[lwt_io non blocking io] file exists [000.253]: finished in 0.000 s[lwt_io non blocking io] file exists (LargeFile) [000.253]: starting[lwt_io non blocking io] file exists (LargeFile) [000.253]: finished in 0.000 s[lwt_io non blocking io] read file [000.253]: starting[lwt_io non blocking io] read file [000.253]: finished in 0.000 s[lwt_io non blocking io] remove file [000.253]: starting[lwt_io non blocking io] remove file [000.253]: finished in 0.000 s[lwt_engine] Lwt_main.run: nested call [000.253]: starting[lwt_engine] Lwt_main.run: nested call [000.253]: finished in 0.000 s[lwt_engine] Lwt_engine.id gives default [000.253]: starting[lwt_engine] Lwt_engine.id gives default [000.253]: finished in 0.000 s[Lwt_timeout] exception in action [000.253]: starting[Lwt_timeout] exception in action [002.255]: finished in 2.002 s[lwt_unix] utimes: basic [002.255]: starting[lwt_unix] utimes: current time [002.255]: starting[lwt_unix] utimes: missing file [002.255]: starting[lwt_unix] readdir: basic [002.255]: starting[lwt_unix] readdir: rewinddir [002.255]: starting[lwt_unix] readdir: readdir_n [002.256]: starting[lwt_unix] readdir: files_of_directory [002.256]: starting[lwt_unix] readdir: already closed [002.256]: starting[lwt_unix] io_vector_byte_count: basic [002.256]: starting[lwt_unix] io_vector_byte_count: basic [002.256]: finished in 0.000 s[lwt_unix] io_vector_byte_count: offsets, partials [002.256]: starting[lwt_unix] io_vector_byte_count: offsets, partials [002.256]: finished in 0.000 s[lwt_unix] io_vector_byte_count: drops [002.256]: starting[lwt_unix] io_vector_byte_count: drops [002.256]: finished in 0.000 s[lwt_unix] readv: basic non-blocking [002.256]: starting[lwt_unix] readv: basic blocking [002.256]: starting[lwt_unix] readv: drop [002.256]: starting[lwt_unix] readv: iovecs exceeding limit [002.256]: starting[lwt_unix] readv: windows [002.256]: skipping[lwt_unix] writev: basic non-blocking [002.256]: starting[lwt_unix] writev: basic blocking [002.257]: starting[lwt_unix] writev: slices [002.257]: starting[lwt_unix] writev: drop, is_empty [002.258]: starting[lwt_unix] writev: degenerate vectors [002.258]: starting[lwt_unix] writev: bad iovec [002.259]: starting[lwt_unix] writev: iovecs exceeding limit [002.259]: starting[lwt_unix] writev: negative drop [002.260]: starting[lwt_unix] writev: windows [002.260]: skipping[lwt_unix] send_msg, recv_msg [002.260]: starting[lwt_unix] send_msg, recv_msg (Lwt_bytes, old) [002.260]: starting[lwt_unix] bind: basic [002.260]: starting[lwt_unix] bind: Unix domain [002.261]: starting[lwt_unix] bind: closed [002.261]: starting[lwt_unix] bind: aborted [002.261]: starting[lwt_unix] getcwd [002.261]: starting[lwt_unix] getcwd and chdir [002.261]: starting[lwt_unix] getcwd and Unix.getcwd [002.261]: starting[lwt_unix] run_in_main [002.261]: starting[lwt_unix] run_in_main_dont_wait [002.261]: starting[lwt_unix] run_in_main_dont_wait_fail [002.261]: starting[lwt_unix] run_in_main_with_dont_wait [002.261]: starting[lwt_unix] getlogin and Unix.getlogin [002.261]: skipping[lwt_unix] getpwnam and Unix.getpwnam [002.261]: skipping[lwt_unix] getpwuid and Unix.getpwuid [002.261]: skipping[lwt_unix] getgrgid and Unix.getgrgid [002.261]: starting[lwt_unix] getgrnam and Unix.getgrnam [002.261]: starting[lwt_io] establish_server_1: shutdown: client closes first [002.262]: starting[lwt_io] open_connection: shutdown: server closes first [002.262]: starting[lwt_io] establish_server: implicit close [002.262]: starting[lwt_io] establish_server: explicit close [002.262]: starting[lwt_io] with_connection [002.262]: starting[lwt_io] with_close_connection: no duplicate exceptions [002.262]: starting[lwt_io] open_temp_file [002.262]: starting[lwt_io] with_temp_filename [002.262]: starting[lwt_io] with_temp_filename close handle [002.262]: starting[lwt_io] create_temp_dir [002.262]: starting[lwt_io] file_length on directory [002.262]: starting[lwt_io] input channel of_bytes initial position [002.262]: starting[lwt_io] input channel of_bytes initial position [002.262]: finished in 0.000 s[lwt_io] input channel of_bytes position after read [002.262]: starting[lwt_io] input channel of_bytes position after read [002.262]: finished in 0.000 s[lwt_io] input channel of_bytes position after set_position [002.262]: starting[lwt_io] input channel of_bytes position after set_position [002.262]: finished in 0.000 s[lwt_io] output channel of_bytes initial position [002.262]: starting[lwt_io] output channel of_bytes initial position [002.262]: finished in 0.000 s[lwt_io] output channel of_bytes position after read [002.262]: starting[lwt_io] output channel of_bytes position after read [002.262]: finished in 0.000 s[lwt_io] output channel of_bytes position after set_position [002.262]: starting[lwt_io] output channel of_bytes position after set_position [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_int [002.262]: starting[lwt_io] NumberIO.LE.read_int [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_int [002.262]: starting[lwt_io] NumberIO.BE.read_int [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_int16 [002.262]: starting[lwt_io] NumberIO.LE.read_int16 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_int16 [002.262]: starting[lwt_io] NumberIO.BE.read_int16 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_int16, negative [002.262]: starting[lwt_io] NumberIO.LE.read_int16, negative [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_int16, negative [002.262]: starting[lwt_io] NumberIO.BE.read_int16, negative [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_int32 [002.262]: starting[lwt_io] NumberIO.LE.read_int32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_int32 [002.262]: starting[lwt_io] NumberIO.BE.read_int32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_int64 [002.262]: starting[lwt_io] NumberIO.LE.read_int64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_int64 [002.262]: starting[lwt_io] NumberIO.BE.read_int64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_float32 [002.262]: starting[lwt_io] NumberIO.LE.read_float32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_float32 [002.262]: starting[lwt_io] NumberIO.BE.read_float32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.read_float64 [002.262]: starting[lwt_io] NumberIO.LE.read_float64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.read_float64 [002.262]: starting[lwt_io] NumberIO.BE.read_float64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_int [002.262]: starting[lwt_io] NumberIO.LE.write_int [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_int [002.262]: starting[lwt_io] NumberIO.BE.write_int [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_int16 [002.262]: starting[lwt_io] NumberIO.LE.write_int16 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_int16 [002.262]: starting[lwt_io] NumberIO.BE.write_int16 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_int32 [002.262]: starting[lwt_io] NumberIO.LE.write_int32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_int32 [002.262]: starting[lwt_io] NumberIO.BE.write_int32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_int64 [002.262]: starting[lwt_io] NumberIO.LE.write_int64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_int64 [002.262]: starting[lwt_io] NumberIO.BE.write_int64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_float32 [002.262]: starting[lwt_io] NumberIO.LE.write_float32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_float32 [002.262]: starting[lwt_io] NumberIO.BE.write_float32 [002.262]: finished in 0.000 s[lwt_io] NumberIO.LE.write_float64 [002.262]: starting[lwt_io] NumberIO.LE.write_float64 [002.262]: finished in 0.000 s[lwt_io] NumberIO.BE.write_float64 [002.262]: starting[lwt_io] NumberIO.BE.write_float64 [002.262]: finished in 0.000 s[lwt_io] Write from Lwt_bytes [002.262]: starting[lwt_io] Write from Lwt_bytes [002.262]: finished in 0.000 s[lwt_io] Read from Lwt_bytes [002.262]: starting[lwt_io] Read from Lwt_bytes [002.262]: finished in 0.000 s[lwt_process] lazy_undefined [002.262]: starting[lwt_process] subproc stdout can be redirected to null [002.263]: starting[lwt_process] subproc stderr can be redirected to null [002.263]: starting[lwt_process] subproc cannot write on closed stdout [002.263]: starting[lwt_process] subproc cannot write on closed stderr [002.264]: starting[lwt_process] can write to subproc stdin [002.264]: starting[lwt_process] can read from subproc stdout [002.265]: starting[lwt_process] can read from subproc stderr [002.265]: starting[lwt_process] overrides env [002.266]: starting[lwt_process] passes env [002.266]: starting[lwt_process] inherits env [002.267]: starting[lwt_engine] libev: timer delays are not too short [002.267]: starting[unix_mcast] mcast-join-loop [003.268]: starting[unix_mcast] mcast-nojoin-loop [003.268]: starting[unix_mcast] mcast-join-noloop [003.268]: starting[unix_mcast] mcast-nojoin-noloop [003.268]: starting[lwt_fmt] flushing [003.268]: starting[lwt_fmt] flushing [003.268]: finished in 0.000 s[lwt_fmt] with combinator [003.268]: starting[lwt_fmt] with combinator [003.268]: finished in 0.000 s[lwt_fmt] box [003.268]: starting[lwt_fmt] box [003.268]: finished in 0.000 s[lwt_fmt] boxsplit [003.268]: starting[lwt_fmt] boxsplit [003.268]: finished in 0.000 s[lwt_fmt] box close with flush [003.268]: starting[lwt_fmt] box close with flush [003.268]: finished in 0.000 s[lwt_fmt] stream [003.268]: starting[lwt_fmt] stream [003.268]: finished in 0.000 s[Lwt_timeout] basic [003.268]: starting[Lwt_timeout] not started [003.268]: starting[Lwt_timeout] double start [003.268]: starting[Lwt_timeout] restart [003.268]: starting[Lwt_timeout] stop [003.268]: starting[Lwt_timeout] stop when not stopped [003.268]: starting[Lwt_timeout] stop when not stopped [003.268]: finished in 0.000 s[Lwt_timeout] invalid delay [003.268]: starting[Lwt_timeout] invalid delay [003.268]: finished in 0.000 s[Lwt_timeout] change [003.268]: starting[Lwt_timeout] change does not start [003.268]: starting[Lwt_timeout] change after start [003.268]: starting[Lwt_timeout] change: invalid delay [003.268]: starting[Lwt_timeout] change: invalid delay [003.268]: finished in 0.000 s[Lwt_timeout] set_exn_handler [003.268]: starting[Lwt_timeout] two [003.268]: starting[Lwt_timeout] simultaneous [003.268]: starting[Lwt_timeout] two, first stopped [003.268]: starting[lwt_bytes] create [003.268]: starting[lwt_bytes] create [003.268]: finished in 0.000 s[lwt_bytes] get/set [003.268]: starting[lwt_bytes] get/set [003.268]: finished in 0.000 s[lwt_bytes] get out of bounds : lower limit [003.268]: starting[lwt_bytes] get out of bounds : lower limit [003.268]: finished in 0.000 s[lwt_bytes] get out of bounds : upper limit [003.268]: starting[lwt_bytes] get out of bounds : upper limit [003.268]: finished in 0.000 s[lwt_bytes] set out of bounds : lower limit [003.268]: starting[lwt_bytes] set out of bounds : lower limit [003.268]: finished in 0.000 s[lwt_bytes] set out of bounds : upper limit [003.268]: starting[lwt_bytes] set out of bounds : upper limit [003.268]: finished in 0.000 s[lwt_bytes] unsafe_get/unsafe_set [003.268]: starting[lwt_bytes] unsafe_get/unsafe_set [003.268]: finished in 0.000 s[lwt_bytes] of bytes [003.268]: starting[lwt_bytes] of bytes [003.268]: finished in 0.000 s[lwt_bytes] of string [003.268]: starting[lwt_bytes] of string [003.268]: finished in 0.000 s[lwt_bytes] to bytes [003.268]: starting[lwt_bytes] to bytes [003.268]: finished in 0.000 s[lwt_bytes] to string [003.268]: starting[lwt_bytes] to string [003.268]: finished in 0.000 s[lwt_bytes] blit [003.268]: starting[lwt_bytes] blit [003.268]: finished in 0.000 s[lwt_bytes] blit source out of bounds: lower limit [003.268]: starting[lwt_bytes] blit source out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit source out of bounds: upper limit [003.268]: starting[lwt_bytes] blit source out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit destination out of bounds: lower limit [003.268]: starting[lwt_bytes] blit destination out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit destination out of bounds: upper limit [003.268]: starting[lwt_bytes] blit destination out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit length out of bounds: lower limit [003.268]: starting[lwt_bytes] blit length out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes [003.268]: starting[lwt_bytes] blit from bytes [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes source out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from bytes source out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes source out of bounds: upper limit [003.268]: starting[lwt_bytes] blit from bytes source out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes destination out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from bytes destination out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes destination out of bounds: upper limit [003.268]: starting[lwt_bytes] blit from bytes destination out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit from bytes length out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from bytes length out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from string [003.268]: starting[lwt_bytes] blit from string [003.268]: finished in 0.000 s[lwt_bytes] blit from string source out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from string source out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from string source out of bounds: upper limit [003.268]: starting[lwt_bytes] blit from string source out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit from string destination out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from string destination out of bounds: lower limit [003.268]: finished in 0.000 s[lwt_bytes] blit from string destination out of bounds: upper limit [003.268]: starting[lwt_bytes] blit from string destination out of bounds: upper limit [003.268]: finished in 0.000 s[lwt_bytes] blit from string length out of bounds: lower limit [003.268]: starting[lwt_bytes] blit from string length out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] blit from string length out of bounds: upper limit [003.269]: starting[lwt_bytes] blit from string length out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes [003.269]: starting[lwt_bytes] blit to bytes [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes source out of bounds: lower limit [003.269]: starting[lwt_bytes] blit to bytes source out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes source out of bounds: upper limit [003.269]: starting[lwt_bytes] blit to bytes source out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes destination out of bounds: lower limit [003.269]: starting[lwt_bytes] blit to bytes destination out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes destination out of bounds: upper limit [003.269]: starting[lwt_bytes] blit to bytes destination out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] blit to bytes length out of bounds: lower limit [003.269]: starting[lwt_bytes] blit to bytes length out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] unsafe blit [003.269]: starting[lwt_bytes] unsafe blit [003.269]: finished in 0.000 s[lwt_bytes] unsafe blit from bytes [003.269]: starting[lwt_bytes] unsafe blit from bytes [003.269]: finished in 0.000 s[lwt_bytes] unsafe blit from string [003.269]: starting[lwt_bytes] unsafe blit from string [003.269]: finished in 0.000 s[lwt_bytes] unsafe blit to bytes [003.269]: starting[lwt_bytes] unsafe blit to bytes [003.269]: finished in 0.000 s[lwt_bytes] proxy [003.269]: starting[lwt_bytes] proxy [003.269]: finished in 0.000 s[lwt_bytes] proxy offset out of bounds: lower limit [003.269]: starting[lwt_bytes] proxy offset out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] proxy offset out of bounds: upper limit [003.269]: starting[lwt_bytes] proxy offset out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] proxy length out of bounds: lower limit [003.269]: starting[lwt_bytes] proxy length out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] extract [003.269]: starting[lwt_bytes] extract [003.269]: finished in 0.000 s[lwt_bytes] extract offset out of bounds: lower limit [003.269]: starting[lwt_bytes] extract offset out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] extract offset out of bounds: upper limit [003.269]: starting[lwt_bytes] extract offset out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] extract length out of bounds: lower limit [003.269]: starting[lwt_bytes] extract length out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] copy [003.269]: starting[lwt_bytes] copy [003.269]: finished in 0.000 s[lwt_bytes] fill [003.269]: starting[lwt_bytes] fill [003.269]: finished in 0.000 s[lwt_bytes] fill offset out of bounds: lower limit [003.269]: starting[lwt_bytes] fill offset out of bounds: lower limit [003.269]: finished in 0.000 s[lwt_bytes] fill offset out of bounds: upper limit [003.269]: starting[lwt_bytes] fill offset out of bounds: upper limit [003.269]: finished in 0.000 s[lwt_bytes] fill length out of bounds lower limit [003.269]: starting[lwt_bytes] fill length out of bounds lower limit [003.269]: finished in 0.000 s[lwt_bytes] unsafe fill [003.269]: starting[lwt_bytes] unsafe fill [003.269]: finished in 0.000 s[lwt_bytes] bytes read [003.269]: starting[lwt_bytes] bytes write [003.269]: starting[lwt_bytes] bytes recv [003.269]: starting[lwt_bytes] bytes send [003.269]: starting[lwt_bytes] bytes recvfrom [003.269]: starting[lwt_bytes] bytes sendto [003.269]: starting[lwt_bytes] bytes recv_msg [003.291]: starting[lwt_bytes] bytes send_msg [003.291]: starting[lwt_bytes] send_msgto [003.291]: starting[lwt_bytes] map_file [003.291]: starting[lwt_bytes] map_file [003.291]: finished in 0.000 s[lwt_bytes] page_size [003.291]: starting[lwt_bytes] page_size [003.291]: finished in 0.000 s[lwt_bytes] mincore buffer length = page_size * 2, n_states = 1 [003.291]: starting[lwt_bytes] mincore buffer length = page_size * 2, n_states = 2 [003.291]: starting[lwt_bytes] mincore buffer length = page_size * 2 + 1, n_states = 2 [003.291]: starting[lwt_bytes] mincore buffer length = page_size , n_states = 0 [003.291]: starting[lwt_bytes] wait_mincore correct bounds [003.291]: starting[lwt_bytes] wait_mincore offset < 0 [003.291]: starting[lwt_bytes] wait_mincore offset > buffer length [003.291]: starting[Lwt_unix sleep and timeout] sleep [003.291]: starting[Lwt_unix sleep and timeout] timeout [003.291]: starting[Lwt_unix sleep and timeout] with_timeout : no timeout [003.291]: starting[Lwt_unix sleep and timeout] with_timeout : timeout [003.291]: starting[Lwt_unix sleep and timeout] pause [003.291]: starting[Lwt_unix sleep and timeout] pause [003.291]: finished in 0.000 s[Lwt_unix sleep and timeout] auto_pause [003.291]: starting[lwt_unix] utimes: basic [003.291]: finished in 1.036 s[lwt_unix] utimes: missing file [003.291]: finished in 1.036 s[lwt_unix] bind: basic [003.296]: finished in 1.036 s[lwt_unix] bind: closed [003.296]: finished in 1.036 s[lwt_unix] bind: aborted [003.296]: finished in 1.036 s[lwt_unix] getcwd [003.296]: finished in 1.036 s[lwt_unix] getcwd and Unix.getcwd [003.296]: finished in 1.036 s[lwt_unix] getgrgid and Unix.getgrgid [003.296]: finished in 1.035 s[lwt_unix] getgrnam and Unix.getgrnam [003.296]: finished in 1.035 s[lwt_io] file_length on directory [003.297]: finished in 1.035 s[unix_mcast] mcast-join-loop [003.297]: finished in 0.029 s[unix_mcast] mcast-nojoin-loop [003.297]: finished in 0.029 s[unix_mcast] mcast-join-noloop [003.297]: finished in 0.029 s[unix_mcast] mcast-nojoin-noloop [003.297]: finished in 0.029 s[Lwt_unix sleep and timeout] with_timeout : no timeout [003.297]: finished in 0.006 s[lwt_process] can write to subproc stdin [003.297]: finished in 1.033 s[lwt_process] subproc cannot write on closed stderr [003.297]: finished in 1.033 s[lwt_process] subproc cannot write on closed stdout [003.297]: finished in 1.033 s[lwt_process] subproc stderr can be redirected to null [003.297]: finished in 1.034 s[lwt_process] subproc stdout can be redirected to null [003.297]: finished in 1.034 s[lwt_process] can read from subproc stdout [003.297]: finished in 1.032 s[lwt_process] can read from subproc stderr [003.297]: finished in 1.032 s[lwt_process] overrides env [003.297]: finished in 1.031 s[lwt_process] passes env [003.297]: finished in 1.031 s[lwt_process] inherits env [003.297]: finished in 1.030 s[lwt_unix] utimes: current time [003.297]: finished in 1.042 s[lwt_unix] readdir: already closed [003.297]: finished in 1.041 s[lwt_unix] readv: basic non-blocking [003.297]: finished in 1.041 s[lwt_unix] readv: drop [003.297]: finished in 1.041 s[lwt_unix] readv: iovecs exceeding limit [003.297]: finished in 1.041 s[lwt_unix] writev: basic non-blocking [003.297]: finished in 1.041 s[lwt_unix] writev: slices [003.297]: finished in 1.040 s[lwt_unix] writev: drop, is_empty [003.297]: finished in 1.039 s[lwt_unix] writev: degenerate vectors [003.297]: finished in 1.039 s[lwt_unix] writev: bad iovec [003.297]: finished in 1.038 s[lwt_unix] writev: iovecs exceeding limit [003.297]: finished in 1.038 s[lwt_unix] writev: negative drop [003.297]: finished in 1.038 s[lwt_unix] bind: Unix domain [003.297]: finished in 1.037 s[lwt_io] with_close_connection: no duplicate exceptions [003.297]: finished in 1.036 s[lwt_io] create_temp_dir [003.298]: finished in 1.036 s[lwt_bytes] bytes recvfrom [003.298]: finished in 0.029 s[lwt_bytes] bytes sendto [003.298]: finished in 0.029 s[lwt_bytes] bytes recv_msg [003.298]: finished in 0.007 s[lwt_bytes] bytes send_msg [003.298]: finished in 0.007 s[lwt_bytes] send_msgto [003.298]: finished in 0.007 s[lwt_process] lazy_undefined [003.298]: finished in 1.036 s[lwt_unix] readdir: files_of_directory [003.298]: finished in 1.042 s[lwt_unix] readv: basic blocking [003.298]: finished in 1.042 s[lwt_unix] writev: basic blocking [003.298]: finished in 1.041 s[lwt_unix] getcwd and chdir [003.298]: finished in 1.037 s[lwt_io] open_temp_file [003.298]: finished in 1.036 s[lwt_bytes] bytes read [003.298]: finished in 0.029 s[lwt_bytes] mincore buffer length = page_size * 2, n_states = 1 [003.298]: finished in 0.007 s[lwt_bytes] mincore buffer length = page_size * 2, n_states = 2 [003.298]: finished in 0.007 s[lwt_bytes] mincore buffer length = page_size * 2 + 1, n_states = 2 [003.298]: finished in 0.007 s[lwt_bytes] mincore buffer length = page_size , n_states = 0 [003.298]: finished in 0.007 s[lwt_bytes] wait_mincore correct bounds [003.298]: finished in 0.007 s[lwt_bytes] wait_mincore offset < 0 [003.298]: finished in 0.007 s[lwt_bytes] wait_mincore offset > buffer length [003.298]: finished in 0.007 s[lwt_unix] run_in_main_dont_wait [003.298]: finished in 1.037 s[lwt_unix] run_in_main_dont_wait_fail [003.298]: finished in 1.037 s[lwt_unix] run_in_main_with_dont_wait [003.298]: finished in 1.037 s[lwt_bytes] bytes recv [003.298]: finished in 0.029 s[lwt_bytes] bytes send [003.298]: finished in 0.029 s[lwt_io] establish_server_1: shutdown: client closes first [003.298]: finished in 1.037 s[lwt_io] with_connection [003.298]: finished in 1.037 s[lwt_unix] readdir: readdir_n [003.298]: finished in 1.043 s[lwt_unix] send_msg, recv_msg [003.298]: finished in 1.038 s[lwt_unix] send_msg, recv_msg (Lwt_bytes, old) [003.298]: finished in 1.038 s[lwt_io] with_temp_filename close handle [003.298]: finished in 1.037 s[lwt_io] open_connection: shutdown: server closes first [003.298]: finished in 1.037 s[lwt_io] establish_server: explicit close [003.298]: finished in 1.037 s[lwt_bytes] bytes write [003.298]: finished in 0.030 s[lwt_io] with_temp_filename [003.299]: finished in 1.037 s[lwt_unix] readdir: basic [003.299]: finished in 1.043 s[lwt_unix] readdir: rewinddir [003.299]: finished in 1.043 s[lwt_unix] run_in_main [003.307]: finished in 1.046 s[lwt_io] establish_server: implicit close [003.349]: finished in 1.087 s[lwt_engine] libev: timer delays are not too short [003.768]: finished in 1.501 s[Lwt_unix sleep and timeout] sleep [004.291]: finished in 1.000 s[Lwt_unix sleep and timeout] timeout [004.291]: finished in 1.000 s[Lwt_unix sleep and timeout] with_timeout : timeout [004.291]: finished in 1.000 s[Lwt_unix sleep and timeout] auto_pause [004.291]: finished in 1.000 s[Lwt_timeout] simultaneous [005.270]: finished in 2.002 s[Lwt_timeout] set_exn_handler [005.270]: finished in 2.002 s[Lwt_timeout] change after start [005.270]: finished in 2.002 s[Lwt_timeout] change [005.270]: finished in 2.002 s[Lwt_timeout] basic [005.270]: finished in 2.002 s[Lwt_timeout] not started [006.269]: finished in 3.001 s[Lwt_timeout] double start [006.269]: finished in 3.001 s[Lwt_timeout] stop [006.269]: finished in 3.001 s[Lwt_timeout] change does not start [006.269]: finished in 3.001 s[Lwt_timeout] two, first stopped [006.270]: finished in 3.002 s[Lwt_timeout] two [006.270]: finished in 3.002 s[Lwt_timeout] restart [006.270]: finished in 3.002 s2026-01-27 08:13.46 ---> saved as "62eb3a6c38131eae5faa8b3218b18080769b96afb5438141e15128e4f735df59"Job succeeded2026-01-27 08:13.46: Job succeeded