[INFO] fetching crate tor-rtmock 0.42.0...
[INFO] testing tor-rtmock-0.42.0 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate tor-rtmock 0.42.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate tor-rtmock 0.42.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tor-rtmock 0.42.0
[INFO] tweaked toml for crates.io crate tor-rtmock 0.42.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tor-rtmock 0.42.0 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate tor-rtmock 0.42.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded value-bag v1.12.0
[INFO] [stderr]   Downloaded zeroize_derive v1.4.3
[INFO] [stderr]   Downloaded tor-general-addr v0.42.0
[INFO] [stderr]   Downloaded visibility v0.1.1
[INFO] [stderr]   Downloaded tor-memquota-cost v0.42.0
[INFO] [stderr]   Downloaded tor-cert-x509 v0.42.0
[INFO] [stderr]   Downloaded rdrand v0.8.3
[INFO] [stderr]   Downloaded merlin v3.0.0
[INFO] [stderr]   Downloaded safelog v0.8.2
[INFO] [stderr]   Downloaded fluid-let v1.0.0
[INFO] [stderr]   Downloaded tls_codec v0.4.2
[INFO] [stderr]   Downloaded ctr v0.9.2
[INFO] [stderr]   Downloaded rand_jitter v0.5.0
[INFO] [stderr]   Downloaded tls_codec_derive v0.4.2
[INFO] [stderr]   Downloaded blanket v0.3.0
[INFO] [stderr]   Downloaded dyn-clone v1.0.20
[INFO] [stderr]   Downloaded coarsetime v0.1.37
[INFO] [stderr]   Downloaded wasm-bindgen-futures v0.4.65
[INFO] [stderr]   Downloaded asynchronous-codec v0.7.0
[INFO] [stderr]   Downloaded gloo-timers v0.3.0
[INFO] [stderr]   Downloaded async-global-executor v2.4.1
[INFO] [stderr]   Downloaded tor-rtcompat v0.42.0
[INFO] [stderr]   Downloaded assert_matches v1.5.0
[INFO] [stderr]   Downloaded futures-await-test v0.3.0
[INFO] [stderr]   Downloaded slotmap-careful v0.7.0
[INFO] [stderr]   Downloaded async-channel v1.9.0
[INFO] [stderr]   Downloaded futures-await-test-macro v0.3.0
[INFO] [stderr]   Downloaded kv-log-macro v1.0.7
[INFO] [stderr]   Downloaded async-process v2.5.0
[INFO] [stderr]   Downloaded blocking v1.6.2
[INFO] [stderr]   Downloaded async-signal v0.2.13
[INFO] [stderr]   Downloaded event-listener v2.5.3
[INFO] [stderr]   Downloaded async-channel v2.5.0
[INFO] [stderr]   Downloaded async-executor v1.14.0
[INFO] [stderr]   Downloaded piper v0.2.5
[INFO] [stderr]   Downloaded async_executors v0.7.0
[INFO] [stderr]   Downloaded futures-lite v2.6.1
[INFO] [stderr]   Downloaded tor-llcrypto v0.42.0
[INFO] [stderr]   Downloaded async-native-tls v0.6.0
[INFO] [stderr]   Downloaded event-listener v5.4.1
[INFO] [stderr]   Downloaded async-io v2.6.0
[INFO] [stderr]   Downloaded priority-queue v2.7.0
[INFO] [stderr]   Downloaded async-lock v3.4.2
[INFO] [stderr]   Downloaded x25519-dalek v2.0.1
[INFO] [stderr]   Downloaded slotmap v1.1.1
[INFO] [stderr]   Downloaded polling v3.11.0
[INFO] [stderr]   Downloaded async-std v1.13.2
[INFO] [stderr]   Downloaded wasix v0.13.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f013f02b914d530cf4e9d5acbdc01cfe00f1284a6aa444b0ea787daab0fabdca
[INFO] running `Command { std: "docker" "start" "-a" "f013f02b914d530cf4e9d5acbdc01cfe00f1284a6aa444b0ea787daab0fabdca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f013f02b914d530cf4e9d5acbdc01cfe00f1284a6aa444b0ea787daab0fabdca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f013f02b914d530cf4e9d5acbdc01cfe00f1284a6aa444b0ea787daab0fabdca", kill_on_drop: false }`
[INFO] [stdout] f013f02b914d530cf4e9d5acbdc01cfe00f1284a6aa444b0ea787daab0fabdca
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 673835d4bfa6d9fac240d5920f291f813a77df7caed0f8fb359efd08f241f38a
[INFO] running `Command { std: "docker" "start" "-a" "673835d4bfa6d9fac240d5920f291f813a77df7caed0f8fb359efd08f241f38a", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling void v1.0.2
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling unicode-segmentation v1.13.2
[INFO] [stderr]    Compiling winnow v1.0.1
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling unicode-xid v0.2.6
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling toml_datetime v1.1.0+spec-1.1.0
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling slotmap v1.1.1
[INFO] [stderr]    Compiling hashbrown v0.12.3
[INFO] [stderr]    Compiling derive-deftly-macros v1.11.0
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling keccak v0.1.6
[INFO] [stderr]    Compiling humantime v2.3.0
[INFO] [stderr]    Compiling convert_case v0.10.0
[INFO] [stderr]    Compiling indexmap v2.13.1
[INFO] [stderr]    Compiling async_executors v0.7.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling retry-error v0.12.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling web-time-compat v0.1.0
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling coarsetime v0.1.37
[INFO] [stderr]    Compiling toml_parser v1.1.0+spec-1.1.0
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling amplify_num v0.5.3
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling ascii v1.1.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling assert_matches v1.5.0
[INFO] [stderr]    Compiling priority-queue v2.7.0
[INFO] [stderr]    Compiling sha3 v0.10.8
[INFO] [stderr]    Compiling toml_edit v0.25.8+spec-1.1.0
[INFO] [stderr]    Compiling proc-macro-crate v3.5.0
[INFO] [stderr]    Compiling amplify_syn v2.0.1
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling amplify_derive v4.0.1
[INFO] [stderr]    Compiling amplify v4.9.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling strum_macros v0.28.0
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling pin-project-internal v1.1.11
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling blanket v0.3.0
[INFO] [stderr]    Compiling enum-ordinalize v3.1.15
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tracing-test-macro v0.2.6
[INFO] [stderr]    Compiling educe v0.4.23
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling pin-project v1.1.11
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling strum v0.28.0
[INFO] [stderr]    Compiling tracing-test v0.2.6
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling tor-general-addr v0.42.0
[INFO] [stderr]    Compiling slotmap-careful v0.7.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling asynchronous-codec v0.7.0
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tor-error v0.42.0
[INFO] [stderr]    Compiling oneshot-fused-workaround v0.6.0
[INFO] [stderr]    Compiling tor-rtcompat v0.42.0
[INFO] [stderr]    Compiling derive-deftly v1.11.0
[INFO] [stderr]    Compiling tor-rtmock v0.42.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 51.03s
[INFO] running `Command { std: "docker" "inspect" "673835d4bfa6d9fac240d5920f291f813a77df7caed0f8fb359efd08f241f38a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "673835d4bfa6d9fac240d5920f291f813a77df7caed0f8fb359efd08f241f38a", kill_on_drop: false }`
[INFO] [stdout] 673835d4bfa6d9fac240d5920f291f813a77df7caed0f8fb359efd08f241f38a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4d827a20eb5ba3e9e46ba3f80beead0ba201fc546cf83cb39d67fe44709c87a2
[INFO] running `Command { std: "docker" "start" "-a" "4d827a20eb5ba3e9e46ba3f80beead0ba201fc546cf83cb39d67fe44709c87a2", kill_on_drop: false }`
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling litemap v0.8.1
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling writeable v0.6.2
[INFO] [stderr]    Compiling icu_properties_data v2.1.2
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling icu_normalizer_data v2.1.1
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling openssl v0.10.76
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling native-tls v0.2.18
[INFO] [stderr]    Compiling cc v1.2.60
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling async_executors v0.7.0
[INFO] [stderr]    Compiling openssl-probe v0.2.1
[INFO] [stderr]    Compiling futures-await-test-macro v0.3.0
[INFO] [stderr]    Compiling weak-table v0.3.2
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling openssl-sys v0.9.112
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling strum_macros v0.28.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling pin-project-internal v1.1.11
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling enum-ordinalize v3.1.15
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling blanket v0.3.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling educe v0.4.23
[INFO] [stderr]    Compiling tracing-test-macro v0.2.6
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling rand v0.9.3
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling pin-project v1.1.11
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling strum v0.28.0
[INFO] [stderr]    Compiling derive-deftly-macros v1.11.0
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling tracing-test v0.2.6
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling slotmap v1.1.1
[INFO] [stderr]    Compiling slotmap-careful v0.7.0
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling asynchronous-codec v0.7.0
[INFO] [stderr]    Compiling tor-general-addr v0.42.0
[INFO] [stderr]    Compiling tor-basic-utils v0.42.0
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling futures-await-test v0.3.0
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling tor-error v0.42.0
[INFO] [stderr]    Compiling oneshot-fused-workaround v0.6.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling async-native-tls v0.6.0
[INFO] [stderr]    Compiling tor-rtcompat v0.42.0
[INFO] [stderr]    Compiling derive-deftly v1.11.0
[INFO] [stderr]    Compiling tor-rtmock v0.42.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 41.29s
[INFO] running `Command { std: "docker" "inspect" "4d827a20eb5ba3e9e46ba3f80beead0ba201fc546cf83cb39d67fe44709c87a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4d827a20eb5ba3e9e46ba3f80beead0ba201fc546cf83cb39d67fe44709c87a2", kill_on_drop: false }`
[INFO] [stdout] 4d827a20eb5ba3e9e46ba3f80beead0ba201fc546cf83cb39d67fe44709c87a2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 21ff3955a8207a72cf05742177cfbef25eaed59e70f82a184b6acd29c16cfe8e
[INFO] running `Command { std: "docker" "start" "-a" "21ff3955a8207a72cf05742177cfbef25eaed59e70f82a184b6acd29c16cfe8e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.31s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tor_rtmock-dfb01bdea99cd67a)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test simple_time::test::simple ... ok
[INFO] [stdout] test io::test::send_error ... ok
[INFO] [stdout] test net::test::pick_listener_addr ... ok
[INFO] [stdout] test io::test::basic_rw ... ok
[INFO] [stdout] test task::test::simple ... ok
[INFO] [stdout] test simple_time::test::task ... ok
[INFO] [stdout] test task::test::drop_reentrancy ... ok
[INFO] [stdout] test runtime::test::advance_by ... ok
[INFO] [stdout] test runtime::test::advance_until ... ok
[INFO] [stdout] test net::test::tls_basics ... ok
[INFO] [stdout] test net::test::end_to_end ... ok
[INFO] [stderr] MockExecutor state:
[INFO] [stderr] Data {
[INFO] [stderr]     tasks: Ti(1v1)="main"=Ps1 Ti(2v1)="0"=fs1 Ti(3v1)="1"=fs1 Ti(4v1)="tx"=fW,
[INFO] [stderr]     awake: Ti(4v1)="tx"=fW,
[INFO] [stderr]     progressing_until_stalled: None,
[INFO] [stderr]     scheduling: Stack,
[INFO] [stderr]     thread_to_run: Exe,
[INFO] [stderr] }
[INFO] [stderr] MockExecutor task dump:
[INFO] [stderr] Ti(1v1)="main"=Ps1: asleep, backtrace 0/1:
[INFO] [stdout] test io::test::drop_reader ... ok
[INFO] [stdout] test net::test::listener_stream ... ok
[INFO] [stderr]    0: <tor_rtmock::task::ActualWaker as core::clone::Clone>::clone
[INFO] [stderr]              at ./src/task.rs:1318:47
[INFO] [stderr]    1: <tor_rtmock::task::ActualWaker>::raw_clone
[INFO] [stderr]              at ./src/task.rs:1222:43
[INFO] [stderr]    2: <core::task::wake::Waker as core::clone::Clone>::clone
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/task/wake.rs:619:29
[INFO] [stderr]    3: <tor_rtmock::task::ProgressUntilStalledFuture as core::future::future::Future>::poll
[INFO] [stderr]              at ./src/task.rs:809:32
[INFO] [stderr]    4: tor_rtmock::task::test::stall::{closure#1}
[INFO] [stderr]              at ./src/task.rs:1608:50
[INFO] [stderr]    5: <core::pin::Pin<alloc::boxed::Box<tor_rtmock::task::test::stall::{closure#1}>> as core::future::future::Future>::poll
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/future/future.rs:133:9
[INFO] [stderr]    6: <&mut core::pin::Pin<alloc::boxed::Box<tor_rtmock::task::test::stall::{closure#1}>> as core::future::future::Future>::poll
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/future/future.rs:121:9
[INFO] [stderr]    7: <tor_rtmock::task::MockExecutor as tor_rtcompat::traits::ToplevelBlockOn>::block_on::<tor_rtmock::task::test::stall::{closure#1}>::{closure#0}
[INFO] [stderr]              at ./src/task.rs:499:35
[INFO] [stderr]    8: <tor_rtmock::task::MockExecutor>::executor_main_loop
[INFO] [stderr]              at ./src/task.rs:667:64
[INFO] [stderr]    9: <tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:626:55
[INFO] [stderr]   10: <core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   11: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   12: __rust_try
[INFO] [stderr]   13: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   14: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   15: <tor_rtmock::task::MockExecutor>::execute_until_first_stall
[INFO] [stderr]              at ./src/task.rs:626:17
[INFO] [stderr]   16: <tor_rtmock::task::MockExecutor>::execute_to_completion
[INFO] [stderr]              at ./src/task.rs:565:18
[INFO] [stderr]   17: <tor_rtmock::task::MockExecutor as tor_rtcompat::traits::ToplevelBlockOn>::block_on::<tor_rtmock::task::test::stall::{closure#1}>
[INFO] [stderr]              at ./src/task.rs:514:18
[INFO] [stderr]   18: tor_rtmock::task::test::stall
[INFO] [stderr]              at ./src/task.rs:1568:17
[INFO] [stderr]   19: tor_rtmock::task::test::stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:1565:15
[INFO] [stderr]   20: <tor_rtmock::task::test::stall::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   21: <fn() -> core::result::Result<(), alloc::string::String> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   22: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stderr]   23: test::run_test_in_process::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stderr]   24: <core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   25: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   26: std::panicking::catch_unwind::<core::result::Result<(), alloc::string::String>, core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   27: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   28: test::run_test_in_process
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stderr]   29: test::run_test::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stderr]   30: test::run_test::{closure#1}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stderr]   31: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stderr]   32: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stderr]   33: <core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   34: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   35: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   36: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   37: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stderr]   38: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   39: <alloc::boxed::Box<dyn core::ops::function::FnOnce<(), Output = ()> + core::marker::Send> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stderr]   40: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stderr]   41: <unknown>
[INFO] [stderr]   42: clone
[INFO] [stderr] 
[INFO] [stderr] Ti(2v1)="0"=fs1: asleep, backtrace 0/1:
[INFO] [stdout] test task::test::spawn_blocking ... ok
[INFO] [stderr]    0: <tor_rtmock::task::ActualWaker as core::clone::Clone>::clone
[INFO] [stdout] test task::test::subthread_oneshot ... ok
[INFO] [stderr]              at ./src/task.rs:1318:47
[INFO] [stderr]    1: <tor_rtmock::task::ActualWaker>::raw_clone
[INFO] [stderr]              at ./src/task.rs:1222:43
[INFO] [stderr]    2: <core::task::wake::Waker as core::clone::Clone>::clone
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/task/wake.rs:619:29
[INFO] [stderr]    3: <futures_core::task::__internal::atomic_waker::AtomicWaker>::register
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-core-0.3.32/src/task/__internal/atomic_waker.rs:279:61
[INFO] [stderr]    4: <futures_channel::mpsc::Receiver<usize> as futures_core::stream::Stream>::poll_next
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-channel-0.3.32/src/mpsc/mod.rs:1140:56
[INFO] [stderr]    5: <futures_channel::mpsc::Receiver<usize> as futures_util::stream::stream::StreamExt>::poll_next_unpin
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/stream/stream/mod.rs:1638:24
[INFO] [stderr]    6: <futures_util::stream::stream::next::Next<futures_channel::mpsc::Receiver<usize>> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/stream/stream/next.rs:32:21
[INFO] [stderr]    7: tor_rtmock::task::test::stall::{closure#1}::{closure#1}
[INFO] [stderr]              at ./src/task.rs:1583:51
[INFO] [stderr]    8: <futures_task::future_obj::LocalFutureObj<()> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-task-0.3.32/src/future_obj.rs:84:56
[INFO] [stderr]    9: <futures_task::future_obj::FutureObj<()> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-task-0.3.32/src/future_obj.rs:127:31
[INFO] [stderr]   10: <futures_task::future_obj::FutureObj<()> as futures_util::future::future::FutureExt>::poll_unpin
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/future/future/mod.rs:556:24
[INFO] [stderr]   11: <tor_rtmock::task::MockExecutor>::executor_main_loop
[INFO] [stderr]              at ./src/task.rs:666:57
[INFO] [stderr]   12: <tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:626:55
[INFO] [stderr]   13: <core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   14: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   15: __rust_try
[INFO] [stderr]   16: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   17: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   18: <tor_rtmock::task::MockExecutor>::execute_until_first_stall
[INFO] [stderr]              at ./src/task.rs:626:17
[INFO] [stderr]   19: <tor_rtmock::task::MockExecutor>::execute_to_completion
[INFO] [stderr]              at ./src/task.rs:565:18
[INFO] [stderr]   20: <tor_rtmock::task::MockExecutor as tor_rtcompat::traits::ToplevelBlockOn>::block_on::<tor_rtmock::task::test::stall::{closure#1}>
[INFO] [stderr]              at ./src/task.rs:514:18
[INFO] [stderr]   21: tor_rtmock::task::test::stall
[INFO] [stderr]              at ./src/task.rs:1568:17
[INFO] [stderr]   22: tor_rtmock::task::test::stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:1565:15
[INFO] [stderr]   23: <tor_rtmock::task::test::stall::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   24: <fn() -> core::result::Result<(), alloc::string::String> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   25: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stderr]   26: test::run_test_in_process::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stderr]   27: <core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   28: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   29: std::panicking::catch_unwind::<core::result::Result<(), alloc::string::String>, core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   30: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   31: test::run_test_in_process
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stderr]   32: test::run_test::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stderr]   33: test::run_test::{closure#1}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stderr]   34: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stderr]   35: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stderr]   36: <core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   37: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   38: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   39: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout] test time::test::basics_of_time_travel ... ok
[INFO] [stderr]   40: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout] test task::test::subthread_pingpong ... ok
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stderr]   41: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   42: <alloc::boxed::Box<dyn core::ops::function::FnOnce<(), Output = ()> + core::marker::Send> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stderr]   43: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stderr]   44: <unknown>
[INFO] [stderr]   45: clone
[INFO] [stderr] 
[INFO] [stderr] Ti(3v1)="1"=fs1: asleep, backtrace 0/1:
[INFO] [stderr]    0: <tor_rtmock::task::ActualWaker as core::clone::Clone>::clone
[INFO] [stderr]              at ./src/task.rs:1318:47
[INFO] [stderr]    1: <tor_rtmock::task::ActualWaker>::raw_clone
[INFO] [stderr]              at ./src/task.rs:1222:43
[INFO] [stderr]    2: <core::task::wake::Waker as core::clone::Clone>::clone
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/task/wake.rs:619:29
[INFO] [stderr]    3: <futures_core::task::__internal::atomic_waker::AtomicWaker>::register
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-core-0.3.32/src/task/__internal/atomic_waker.rs:279:61
[INFO] [stderr]    4: <futures_channel::mpsc::Receiver<usize> as futures_core::stream::Stream>::poll_next
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-channel-0.3.32/src/mpsc/mod.rs:1140:56
[INFO] [stderr]    5: <futures_channel::mpsc::Receiver<usize> as futures_util::stream::stream::StreamExt>::poll_next_unpin
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/stream/stream/mod.rs:1638:24
[INFO] [stderr]    6: <futures_util::stream::stream::next::Next<futures_channel::mpsc::Receiver<usize>> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/stream/stream/next.rs:32:21
[INFO] [stderr]    7: tor_rtmock::task::test::stall::{closure#1}::{closure#1}
[INFO] [stderr]              at ./src/task.rs:1583:51
[INFO] [stderr]    8: <futures_task::future_obj::LocalFutureObj<()> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-task-0.3.32/src/future_obj.rs:84:56
[INFO] [stderr]    9: <futures_task::future_obj::FutureObj<()> as core::future::future::Future>::poll
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-task-0.3.32/src/future_obj.rs:127:31
[INFO] [stderr]   10: <futures_task::future_obj::FutureObj<()> as futures_util::future::future::FutureExt>::poll_unpin
[INFO] [stderr]              at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-util-0.3.32/src/future/future/mod.rs:556:24
[INFO] [stderr]   11: <tor_rtmock::task::MockExecutor>::executor_main_loop
[INFO] [stderr]              at ./src/task.rs:666:57
[INFO] [stderr]   12: <tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:626:55
[INFO] [stderr]   13: <core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   14: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   15: __rust_try
[INFO] [stderr]   16: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   17: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<<tor_rtmock::task::MockExecutor>::execute_until_first_stall::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   18: <tor_rtmock::task::MockExecutor>::execute_until_first_stall
[INFO] [stderr]              at ./src/task.rs:626:17
[INFO] [stderr]   19: <tor_rtmock::task::MockExecutor>::execute_to_completion
[INFO] [stderr]              at ./src/task.rs:565:18
[INFO] [stderr]   20: <tor_rtmock::task::MockExecutor as tor_rtcompat::traits::ToplevelBlockOn>::block_on::<tor_rtmock::task::test::stall::{closure#1}>
[INFO] [stderr]              at ./src/task.rs:514:18
[INFO] [stderr]   21: tor_rtmock::task::test::stall
[INFO] [stderr]              at ./src/task.rs:1568:17
[INFO] [stderr]   22: tor_rtmock::task::test::stall::{closure#0}
[INFO] [stderr]              at ./src/task.rs:1565:15
[INFO] [stderr]   23: <tor_rtmock::task::test::stall::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   24: <fn() -> core::result::Result<(), alloc::string::String> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stderr]   25: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stderr]   26: test::run_test_in_process::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stderr]   27: <core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   28: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   29: std::panicking::catch_unwind::<core::result::Result<(), alloc::string::String>, core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   30: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<test::run_test_in_process::{closure#0}>, core::result::Result<(), alloc::string::String>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   31: test::run_test_in_process
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stderr]   32: test::run_test::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stderr]   33: test::run_test::{closure#1}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stderr]   34: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stderr]   35: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stderr]   36: <core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stderr]   37: std::panicking::catch_unwind::do_call::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stderr]   38: std::panicking::catch_unwind::<(), core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stderr]   39: std::panic::catch_unwind::<core::panic::unwind_safe::AssertUnwindSafe<std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout] test runtime::test::advance_until_stalled ... ok
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stderr]   40: std::thread::lifecycle::spawn_unchecked::<test::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stderr]   41: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout] test time::test::time_moves_on ... ok
[INFO] [stderr]   42: <alloc::boxed::Box<dyn core::ops::function::FnOnce<(), Output = ()> + core::marker::Send> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stderr]   43: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stderr]              at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stderr]   44: <unknown>
[INFO] [stderr]   45: clone
[INFO] [stderr] 
[INFO] [stderr] Ti(4v1)="tx"=fW: awake
[INFO] [stderr] 
[INFO] [stderr] Note: there might be spurious traces, see docs for MockExecutor::debug_dump
[INFO] [stderr] 
[INFO] [stdout] test task::test::stall ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/rtcompat_timing.rs (/opt/rustwide/target/debug/deps/rtcompat_timing-18de6ecd0d22c4be)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test wallclock_early ... ok
[INFO] [stdout] test wallclock_simple ... ok
[INFO] [stdout] test wallclock_jump_backwards ... ok
[INFO] [stdout] test wallclock_jump_forward ... ok
[INFO] [stderr]    Doc-tests tor_rtmock
[INFO] [stdout] test timeouts ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test src/time.rs - time::MockSleepProvider (line 111) - compile ... ok
[INFO] [stdout] test src/time.rs - time::MockSleepProvider (line 79) ... ok
[INFO] [stdout] test src/lib.rs - (line 87) ... ok
[INFO] [stdout] test src/net.rs - net::MockNetwork::builder (line 184) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.05s; merged doctests compilation took 1.02s
[INFO] running `Command { std: "docker" "inspect" "21ff3955a8207a72cf05742177cfbef25eaed59e70f82a184b6acd29c16cfe8e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21ff3955a8207a72cf05742177cfbef25eaed59e70f82a184b6acd29c16cfe8e", kill_on_drop: false }`
[INFO] [stdout] 21ff3955a8207a72cf05742177cfbef25eaed59e70f82a184b6acd29c16cfe8e
