[INFO] crate tokio-by-hand 0.0.0 is already in cache [INFO] testing tokio-by-hand-0.0.0 against try#41997647ba6a77908f6ef64401414feb00bccf16 for pr-71274 [INFO] extracting crate tokio-by-hand 0.0.0 into /workspace/builds/worker-2/source [INFO] validating manifest of crates.io crate tokio-by-hand 0.0.0 on toolchain 41997647ba6a77908f6ef64401414feb00bccf16 [INFO] running `"/workspace/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started tweaking crates.io crate tokio-by-hand 0.0.0 [INFO] finished tweaking crates.io crate tokio-by-hand 0.0.0 [INFO] tweaked toml for crates.io crate tokio-by-hand 0.0.0 written to /workspace/builds/worker-2/source/Cargo.toml [INFO] running `"/workspace/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/workspace/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "build" "--frozen"` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 4dbd13af402d844aa3e906e8419b569f0341c8547920fa252ac96441a80a6e9a [INFO] running `"docker" "start" "-a" "4dbd13af402d844aa3e906e8419b569f0341c8547920fa252ac96441a80a6e9a"` [INFO] [stderr] Compiling void v1.0.2 [INFO] [stderr] Compiling tokio-core v0.1.17 [INFO] [stderr] Compiling tokio-by-hand v0.0.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.11s [INFO] running `"docker" "inspect" "4dbd13af402d844aa3e906e8419b569f0341c8547920fa252ac96441a80a6e9a"` [INFO] running `"docker" "rm" "-f" "4dbd13af402d844aa3e906e8419b569f0341c8547920fa252ac96441a80a6e9a"` [INFO] [stdout] 4dbd13af402d844aa3e906e8419b569f0341c8547920fa252ac96441a80a6e9a [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "test" "--frozen" "--no-run"` [INFO] [stdout] 7c0c46b24a3e3ddf363addf7f305c249a96315d1f4390a096070d55deb5d7439 [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `"docker" "start" "-a" "7c0c46b24a3e3ddf363addf7f305c249a96315d1f4390a096070d55deb5d7439"` [INFO] [stderr] Compiling tokio-by-hand v0.0.0 (/opt/rustwide/workdir) [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/instant_series.rs:91:7 [INFO] [stderr] | [INFO] [stderr] 91 | producer.forward(consumer).wait().unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_must_use)]` on by default [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:73:5 [INFO] [stderr] | [INFO] [stderr] 73 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:87:5 [INFO] [stderr] | [INFO] [stderr] 87 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:102:5 [INFO] [stderr] | [INFO] [stderr] 102 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/buffered.rs:67:5 [INFO] [stderr] | [INFO] [stderr] 67 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/instant_series.rs:115:7 [INFO] [stderr] | [INFO] [stderr] 115 | producer.forward(consumer).wait().unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:98:5 [INFO] [stderr] | [INFO] [stderr] 98 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:112:5 [INFO] [stderr] | [INFO] [stderr] 112 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:127:5 [INFO] [stderr] | [INFO] [stderr] 127 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/buffered.rs:90:5 [INFO] [stderr] | [INFO] [stderr] 90 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Map` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/adapter.rs:130:5 [INFO] [stderr] | [INFO] [stderr] 130 | / stream [INFO] [stderr] 131 | | .take(7) [INFO] [stderr] 132 | | .inspect(|x| println!("from stream: {:?}", x)) [INFO] [stderr] 133 | | .map(|x| Outgoing(x.0)) [INFO] [stderr] 134 | | .forward(sink).wait().unwrap(); [INFO] [stderr] | |_____________________________________^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: 11 warnings emitted [INFO] [stderr] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 4.14s [INFO] running `"docker" "inspect" "7c0c46b24a3e3ddf363addf7f305c249a96315d1f4390a096070d55deb5d7439"` [INFO] running `"docker" "rm" "-f" "7c0c46b24a3e3ddf363addf7f305c249a96315d1f4390a096070d55deb5d7439"` [INFO] [stdout] 7c0c46b24a3e3ddf363addf7f305c249a96315d1f4390a096070d55deb5d7439 [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+41997647ba6a77908f6ef64401414feb00bccf16" "test" "--frozen"` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] e146eb65f7a62d3421432a3eb8bdfa640d024e79c30a60864bbb4a498ac68827 [INFO] running `"docker" "start" "-a" "e146eb65f7a62d3421432a3eb8bdfa640d024e79c30a60864bbb4a498ac68827"` [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/instant_series.rs:91:7 [INFO] [stderr] | [INFO] [stderr] 91 | producer.forward(consumer).wait().unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_must_use)]` on by default [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:73:5 [INFO] [stderr] | [INFO] [stderr] 73 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:87:5 [INFO] [stderr] | [INFO] [stderr] 87 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/delayed_series.rs:102:5 [INFO] [stderr] | [INFO] [stderr] 102 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/standard/buffered.rs:67:5 [INFO] [stderr] | [INFO] [stderr] 67 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/instant_series.rs:115:7 [INFO] [stderr] | [INFO] [stderr] 115 | producer.forward(consumer).wait().unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:98:5 [INFO] [stderr] | [INFO] [stderr] 98 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:112:5 [INFO] [stderr] | [INFO] [stderr] 112 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/delayed_series.rs:127:5 [INFO] [stderr] | [INFO] [stderr] 127 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Take` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/buffered.rs:90:5 [INFO] [stderr] | [INFO] [stderr] 90 | core.run(producer.forward(consumer)).unwrap(); [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: unused `futures::stream::Map` in tuple element 0 that must be used [INFO] [stderr] --> src/extended/adapter.rs:130:5 [INFO] [stderr] | [INFO] [stderr] 130 | / stream [INFO] [stderr] 131 | | .take(7) [INFO] [stderr] 132 | | .inspect(|x| println!("from stream: {:?}", x)) [INFO] [stderr] 133 | | .map(|x| Outgoing(x.0)) [INFO] [stderr] 134 | | .forward(sink).wait().unwrap(); [INFO] [stderr] | |_____________________________________^ [INFO] [stderr] | [INFO] [stderr] = note: streams do nothing unless polled [INFO] [stderr] [INFO] [stderr] warning: 11 warnings emitted [INFO] [stderr] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.19s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/tokio_by_hand-bd85b63b33455971 [INFO] [stdout] [INFO] [stdout] running 29 tests [INFO] [stdout] test extended::instant::tests::consumer_completes_quickly ... ok [INFO] [stdout] test extended::instant::tests::producer_returns_all_values ... ok [INFO] [stdout] test extended::instant::tests::producer_completes_quickly ... ok [INFO] [stdout] test extended::instant_series::tests::producer_returns_all_values ... ok [INFO] [stdout] test extended::instant_series::tests::forward_to_consumer ... ok [INFO] [stdout] test extended::sleeper::tests::with_wait ... ok [INFO] [stdout] test extended::delayed::tests::consumer_completes_in_about_one_second ... ok [INFO] [stdout] test extended::sleeper::tests::with_core ... ok [INFO] [stdout] test standard::delayed::tests::consumer_completes_in_about_one_second ... ok [INFO] [stdout] test standard::instant::tests::consumer_completes_quickly ... ok [INFO] [stdout] test standard::instant::tests::producer_returns_all_values ... ok [INFO] [stdout] test standard::instant_series::tests::forward_to_consumer ... ok [INFO] [stdout] test standard::instant::tests::producer_completes_quickly ... ok [INFO] [stdout] test standard::instant_series::tests::producer_returns_all_values ... ok [INFO] [stdout] test extended::delayed::tests::producer_completes_in_about_one_second ... FAILED [INFO] [stdout] test standard::delayed::tests::producer_completes_in_about_one_second ... FAILED [INFO] [stdout] test standard::sleeper::tests::with_wait ... ok [INFO] [stdout] test standard::sleeper::tests::with_core ... ok [INFO] [stdout] test standard::delayed::tests::producer_returns_all_values ... ok [INFO] [stdout] test extended::delayed::tests::producer_returns_all_values ... ok [INFO] [stdout] test extended::delayed_series::tests::values_take_one_second_to_consume ... ok [INFO] [stdout] test extended::delayed_series::tests::values_take_one_second_to_produce ... ok [INFO] [stdout] test standard::delayed_series::tests::values_take_one_second_to_consume ... ok [INFO] [stdout] test standard::delayed_series::tests::values_take_one_second_to_produce ... ok [INFO] [stdout] test standard::delayed_series::tests::production_and_consumption_are_concurrent ... ok [INFO] [stdout] test extended::buffered::tests::production_and_consumption_are_concurrent ... ok [INFO] [stdout] test standard::buffered::tests::production_and_consumption_are_concurrent ... ok [INFO] [stdout] test extended::delayed_series::tests::production_and_consumption_are_concurrent ... ok [INFO] [stdout] test extended::adapter::tests::basic ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- extended::delayed::tests::producer_completes_in_about_one_second stdout ---- [INFO] [stdout] thread 'extended::delayed::tests::producer_completes_in_about_one_second' panicked at 'assertion failed: elapsed < Duration::new(1, 200_000_000)', src/extended/delayed.rs:92:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5598f293d4f4 - backtrace::backtrace::libunwind::trace::h61666fa4b9834a45 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/libunwind.rs:86 [INFO] [stdout] 1: 0x5598f293d4f4 - backtrace::backtrace::trace_unsynchronized::h01d3725fb5da8653 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5598f293d4f4 - std::sys_common::backtrace::_print_fmt::h5c7c4751bc296f90 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:78 [INFO] [stdout] 3: 0x5598f293d4f4 - ::fmt::h7729313ad2d729c7 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:59 [INFO] [stdout] 4: 0x5598f296626c - core::fmt::write::hb0049f6c12bdaffc [INFO] [stdout] at src/libcore/fmt/mod.rs:1069 [INFO] [stdout] 5: 0x5598f27d31a5 - std::io::Write::write_fmt::h5d052af13df32ea6 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/io/mod.rs:1504 [INFO] [stdout] 6: 0x5598f2937611 - std::io::impls::>::write_fmt::h8fe8a9bdc421b4b6 [INFO] [stdout] at src/libstd/io/impls.rs:156 [INFO] [stdout] 7: 0x5598f293fdd5 - std::sys_common::backtrace::_print::ha087cac92e84a414 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:62 [INFO] [stdout] 8: 0x5598f293fdd5 - std::sys_common::backtrace::print::h6b013d3bfe6cbcb8 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:49 [INFO] [stdout] 9: 0x5598f293fdd5 - std::panicking::default_hook::{{closure}}::h016d7de02def2736 [INFO] [stdout] at src/libstd/panicking.rs:198 [INFO] [stdout] 10: 0x5598f293fabb - std::panicking::default_hook::h9386f7e484840463 [INFO] [stdout] at src/libstd/panicking.rs:215 [INFO] [stdout] 11: 0x5598f2940432 - std::panicking::rust_panic_with_hook::h3846eb1b2e5a9312 [INFO] [stdout] at src/libstd/panicking.rs:511 [INFO] [stdout] 12: 0x5598f2901541 - std::panicking::begin_panic::ha518aba066134835 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:438 [INFO] [stdout] 13: 0x5598f2780a73 - tokio_by_hand::extended::delayed::tests::producer_completes_in_about_one_second::h0a5b1c53630aa038 [INFO] [stdout] at src/extended/delayed.rs:92 [INFO] [stdout] 14: 0x5598f27808ca - tokio_by_hand::extended::delayed::tests::producer_completes_in_about_one_second::{{closure}}::h71824a3c604711c9 [INFO] [stdout] at src/extended/delayed.rs:86 [INFO] [stdout] 15: 0x5598f27b17fe - core::ops::function::FnOnce::call_once::h24207e1a212bae14 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libcore/ops/function.rs:232 [INFO] [stdout] 16: 0x5598f27df09f - as core::ops::function::FnOnce>::call_once::h1f6ee40732e80908 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 17: 0x5598f27fa69e - as core::ops::function::FnOnce<()>>::call_once::h85dff111be9c2dc6 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:318 [INFO] [stdout] 18: 0x5598f27fa69e - std::panicking::try::do_call::hee6f5a4bef67c840 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:331 [INFO] [stdout] 19: 0x5598f27fa69e - std::panicking::try::h3384d3b948e84dbc [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:274 [INFO] [stdout] 20: 0x5598f27fa69e - std::panic::catch_unwind::h5ae91218e578066d [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:394 [INFO] [stdout] 21: 0x5598f27fa69e - test::run_test_in_process::he37a49587889b910 [INFO] [stdout] at src/libtest/lib.rs:541 [INFO] [stdout] 22: 0x5598f27fa69e - test::run_test::run_test_inner::{{closure}}::h4f0d25136ca480c2 [INFO] [stdout] at src/libtest/lib.rs:450 [INFO] [stdout] 23: 0x5598f27d2656 - std::sys_common::backtrace::__rust_begin_short_backtrace::h969eceda34247af3 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/sys_common/backtrace.rs:130 [INFO] [stdout] 24: 0x5598f27d79e5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h912007997cb04e92 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/thread/mod.rs:475 [INFO] [stdout] 25: 0x5598f27d79e5 - as core::ops::function::FnOnce<()>>::call_once::h8795d8b7bd223988 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:318 [INFO] [stdout] 26: 0x5598f27d79e5 - std::panicking::try::do_call::hb29b86f86d4d722e [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:331 [INFO] [stdout] 27: 0x5598f27d79e5 - std::panicking::try::h4bfefb3eddc0d900 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:274 [INFO] [stdout] 28: 0x5598f27d79e5 - std::panic::catch_unwind::h774c24d4b38d5828 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:394 [INFO] [stdout] 29: 0x5598f27d79e5 - std::thread::Builder::spawn_unchecked::{{closure}}::ha50a32fa99413dde [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/thread/mod.rs:474 [INFO] [stdout] 30: 0x5598f27d79e5 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9dacb8f28d699f86 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libcore/ops/function.rs:232 [INFO] [stdout] 31: 0x5598f29334ff - as core::ops::function::FnOnce>::call_once::h7deaeeba480c6ce2 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 32: 0x5598f2946ce3 - as core::ops::function::FnOnce>::call_once::h968b1dfb87756523 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 33: 0x5598f2946ce3 - std::sys::unix::thread::Thread::new::thread_start::h2399addeb6370595 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:87 [INFO] [stdout] 34: 0x7f5ac4b6d6db - start_thread [INFO] [stdout] 35: 0x7f5ac467e88f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- standard::delayed::tests::producer_completes_in_about_one_second stdout ---- [INFO] [stdout] thread 'standard::delayed::tests::producer_completes_in_about_one_second' panicked at 'assertion failed: elapsed < Duration::new(1, 200_000_000)', src/standard/delayed.rs:74:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5598f293d4f4 - backtrace::backtrace::libunwind::trace::h61666fa4b9834a45 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/libunwind.rs:86 [INFO] [stdout] 1: 0x5598f293d4f4 - backtrace::backtrace::trace_unsynchronized::h01d3725fb5da8653 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5598f293d4f4 - std::sys_common::backtrace::_print_fmt::h5c7c4751bc296f90 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:78 [INFO] [stdout] 3: 0x5598f293d4f4 - ::fmt::h7729313ad2d729c7 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:59 [INFO] [stdout] 4: 0x5598f296626c - core::fmt::write::hb0049f6c12bdaffc [INFO] [stdout] at src/libcore/fmt/mod.rs:1069 [INFO] [stdout] 5: 0x5598f27d31a5 - std::io::Write::write_fmt::h5d052af13df32ea6 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/io/mod.rs:1504 [INFO] [stdout] 6: 0x5598f2937611 - std::io::impls::>::write_fmt::h8fe8a9bdc421b4b6 [INFO] [stdout] at src/libstd/io/impls.rs:156 [INFO] [stdout] 7: 0x5598f293fdd5 - std::sys_common::backtrace::_print::ha087cac92e84a414 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:62 [INFO] [stdout] 8: 0x5598f293fdd5 - std::sys_common::backtrace::print::h6b013d3bfe6cbcb8 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:49 [INFO] [stdout] 9: 0x5598f293fdd5 - std::panicking::default_hook::{{closure}}::h016d7de02def2736 [INFO] [stdout] at src/libstd/panicking.rs:198 [INFO] [stdout] 10: 0x5598f293fabb - std::panicking::default_hook::h9386f7e484840463 [INFO] [stdout] at src/libstd/panicking.rs:215 [INFO] [stdout] 11: 0x5598f2940432 - std::panicking::rust_panic_with_hook::h3846eb1b2e5a9312 [INFO] [stdout] at src/libstd/panicking.rs:511 [INFO] [stdout] 12: 0x5598f2901541 - std::panicking::begin_panic::ha518aba066134835 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:438 [INFO] [stdout] 13: 0x5598f277fa13 - tokio_by_hand::standard::delayed::tests::producer_completes_in_about_one_second::h78646137ff4bc9df [INFO] [stdout] at src/standard/delayed.rs:74 [INFO] [stdout] 14: 0x5598f277f86a - tokio_by_hand::standard::delayed::tests::producer_completes_in_about_one_second::{{closure}}::hfb885f38f713bfef [INFO] [stdout] at src/standard/delayed.rs:68 [INFO] [stdout] 15: 0x5598f27b1b3e - core::ops::function::FnOnce::call_once::h36789c0dde8b73ea [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libcore/ops/function.rs:232 [INFO] [stdout] 16: 0x5598f27df09f - as core::ops::function::FnOnce>::call_once::h1f6ee40732e80908 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 17: 0x5598f27fa69e - as core::ops::function::FnOnce<()>>::call_once::h85dff111be9c2dc6 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:318 [INFO] [stdout] 18: 0x5598f27fa69e - std::panicking::try::do_call::hee6f5a4bef67c840 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:331 [INFO] [stdout] 19: 0x5598f27fa69e - std::panicking::try::h3384d3b948e84dbc [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:274 [INFO] [stdout] 20: 0x5598f27fa69e - std::panic::catch_unwind::h5ae91218e578066d [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:394 [INFO] [stdout] 21: 0x5598f27fa69e - test::run_test_in_process::he37a49587889b910 [INFO] [stdout] at src/libtest/lib.rs:541 [INFO] [stdout] 22: 0x5598f27fa69e - test::run_test::run_test_inner::{{closure}}::h4f0d25136ca480c2 [INFO] [stdout] at src/libtest/lib.rs:450 [INFO] [stdout] 23: 0x5598f27d2656 - std::sys_common::backtrace::__rust_begin_short_backtrace::h969eceda34247af3 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/sys_common/backtrace.rs:130 [INFO] [stdout] 24: 0x5598f27d79e5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h912007997cb04e92 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/thread/mod.rs:475 [INFO] [stdout] 25: 0x5598f27d79e5 - as core::ops::function::FnOnce<()>>::call_once::h8795d8b7bd223988 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:318 [INFO] [stdout] 26: 0x5598f27d79e5 - std::panicking::try::do_call::hb29b86f86d4d722e [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:331 [INFO] [stdout] 27: 0x5598f27d79e5 - std::panicking::try::h4bfefb3eddc0d900 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panicking.rs:274 [INFO] [stdout] 28: 0x5598f27d79e5 - std::panic::catch_unwind::h774c24d4b38d5828 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/panic.rs:394 [INFO] [stdout] 29: 0x5598f27d79e5 - std::thread::Builder::spawn_unchecked::{{closure}}::ha50a32fa99413dde [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libstd/thread/mod.rs:474 [INFO] [stdout] 30: 0x5598f27d79e5 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9dacb8f28d699f86 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/libcore/ops/function.rs:232 [INFO] [stdout] 31: 0x5598f29334ff - as core::ops::function::FnOnce>::call_once::h7deaeeba480c6ce2 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 32: 0x5598f2946ce3 - as core::ops::function::FnOnce>::call_once::h968b1dfb87756523 [INFO] [stdout] at /rustc/41997647ba6a77908f6ef64401414feb00bccf16/src/liballoc/boxed.rs:1008 [INFO] [stdout] 33: 0x5598f2946ce3 - std::sys::unix::thread::Thread::new::thread_start::h2399addeb6370595 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:87 [INFO] [stdout] 34: 0x7f5ac4b6d6db - start_thread [INFO] [stdout] 35: 0x7f5ac467e88f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] extended::delayed::tests::producer_completes_in_about_one_second [INFO] [stdout] standard::delayed::tests::producer_completes_in_about_one_second [INFO] [stdout] [INFO] [stdout] test result: FAILED. 27 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--lib' [INFO] running `"docker" "inspect" "e146eb65f7a62d3421432a3eb8bdfa640d024e79c30a60864bbb4a498ac68827"` [INFO] running `"docker" "rm" "-f" "e146eb65f7a62d3421432a3eb8bdfa640d024e79c30a60864bbb4a498ac68827"` [INFO] [stdout] e146eb65f7a62d3421432a3eb8bdfa640d024e79c30a60864bbb4a498ac68827