[INFO] fetching crate tokio-timer-plus 0.1.3... [INFO] testing tokio-timer-plus-0.1.3 against 1.49.0 for beta-1.50-1 [INFO] extracting crate tokio-timer-plus 0.1.3 into /workspace/builds/worker-8/source [INFO] validating manifest of crates.io crate tokio-timer-plus 0.1.3 on toolchain 1.49.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.49.0" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] started tweaking crates.io crate tokio-timer-plus 0.1.3 [INFO] finished tweaking crates.io crate tokio-timer-plus 0.1.3 [INFO] tweaked toml for crates.io crate tokio-timer-plus 0.1.3 written to /workspace/builds/worker-8/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.49.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.49.0" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 83ea7f8469547667a05a462c13f1a0c137c179d86efe55f38fa78b3028b6eb46 [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "83ea7f8469547667a05a462c13f1a0c137c179d86efe55f38fa78b3028b6eb46", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "83ea7f8469547667a05a462c13f1a0c137c179d86efe55f38fa78b3028b6eb46", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "83ea7f8469547667a05a462c13f1a0c137c179d86efe55f38fa78b3028b6eb46", kill_on_drop: false }` [INFO] [stdout] 83ea7f8469547667a05a462c13f1a0c137c179d86efe55f38fa78b3028b6eb46 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] d76f055c978c23c9495a26b3f619c8890f1fdd7f3e1b96616cffe1295f39283e [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "d76f055c978c23c9495a26b3f619c8890f1fdd7f3e1b96616cffe1295f39283e", kill_on_drop: false }` [INFO] [stderr] Compiling slab v0.3.0 [INFO] [stderr] Compiling tokio-timer-plus v0.1.3 (/opt/rustwide/workdir) [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:421:27 [INFO] [stdout] | [INFO] [stdout] 421 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] note: the lint level is defined here [INFO] [stdout] --> src/lib.rs:88:9 [INFO] [stdout] | [INFO] [stdout] 88 | #![deny(warnings, missing_docs, missing_debug_implementations)] [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] = note: `#[warn(deprecated)]` implied by `#[warn(warnings)]` [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:436:27 [INFO] [stdout] | [INFO] [stdout] 436 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:442:27 [INFO] [stdout] | [INFO] [stdout] 442 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 3 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.77s [INFO] running `Command { std: "docker" "inspect" "d76f055c978c23c9495a26b3f619c8890f1fdd7f3e1b96616cffe1295f39283e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d76f055c978c23c9495a26b3f619c8890f1fdd7f3e1b96616cffe1295f39283e", kill_on_drop: false }` [INFO] [stdout] d76f055c978c23c9495a26b3f619c8890f1fdd7f3e1b96616cffe1295f39283e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8e7682b86912659dd0ecdb1086e3df532d26fb23714d1d94bcec362d0cd8682a [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "8e7682b86912659dd0ecdb1086e3df532d26fb23714d1d94bcec362d0cd8682a", kill_on_drop: false }` [INFO] [stderr] Compiling tokio-timer-plus v0.1.3 (/opt/rustwide/workdir) [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:421:27 [INFO] [stdout] | [INFO] [stdout] 421 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] note: the lint level is defined here [INFO] [stdout] --> src/lib.rs:88:9 [INFO] [stdout] | [INFO] [stdout] 88 | #![deny(warnings, missing_docs, missing_debug_implementations)] [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] = note: `#[warn(deprecated)]` implied by `#[warn(warnings)]` [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:436:27 [INFO] [stdout] | [INFO] [stdout] 436 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:442:27 [INFO] [stdout] | [INFO] [stdout] 442 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 3 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:421:27 [INFO] [stdout] | [INFO] [stdout] 421 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] note: the lint level is defined here [INFO] [stdout] --> src/lib.rs:88:9 [INFO] [stdout] | [INFO] [stdout] 88 | #![deny(warnings, missing_docs, missing_debug_implementations)] [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] = note: `#[warn(deprecated)]` implied by `#[warn(warnings)]` [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:436:27 [INFO] [stdout] | [INFO] [stdout] 436 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stdout] --> src/timer.rs:442:27 [INFO] [stdout] | [INFO] [stdout] 442 | write!(fmt, "{}", Error::description(self)) [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 3 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 3.39s [INFO] running `Command { std: "docker" "inspect" "8e7682b86912659dd0ecdb1086e3df532d26fb23714d1d94bcec362d0cd8682a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8e7682b86912659dd0ecdb1086e3df532d26fb23714d1d94bcec362d0cd8682a", kill_on_drop: false }` [INFO] [stdout] 8e7682b86912659dd0ecdb1086e3df532d26fb23714d1d94bcec362d0cd8682a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 967f7e58d2f215441b43db56b3661fcacfea9f34dceb3cd59b6272bfaa5b9534 [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "967f7e58d2f215441b43db56b3661fcacfea9f34dceb3cd59b6272bfaa5b9534", kill_on_drop: false }` [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:421:27 [INFO] [stderr] | [INFO] [stderr] 421 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] note: the lint level is defined here [INFO] [stderr] --> src/lib.rs:88:9 [INFO] [stderr] | [INFO] [stderr] 88 | #![deny(warnings, missing_docs, missing_debug_implementations)] [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] = note: `#[warn(deprecated)]` implied by `#[warn(warnings)]` [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:436:27 [INFO] [stderr] | [INFO] [stderr] 436 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:442:27 [INFO] [stderr] | [INFO] [stderr] 442 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: 3 warnings emitted [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:421:27 [INFO] [stderr] | [INFO] [stderr] 421 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] note: the lint level is defined here [INFO] [stderr] --> src/lib.rs:88:9 [INFO] [stderr] | [INFO] [stderr] 88 | #![deny(warnings, missing_docs, missing_debug_implementations)] [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] = note: `#[warn(deprecated)]` implied by `#[warn(warnings)]` [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:436:27 [INFO] [stderr] | [INFO] [stderr] 436 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: use of deprecated associated function `std::error::Error::description`: use the Display impl or to_string() [INFO] [stderr] --> src/timer.rs:442:27 [INFO] [stderr] | [INFO] [stderr] 442 | write!(fmt, "{}", Error::description(self)) [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: 3 warnings emitted [INFO] [stderr] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.02s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/tokio_timer-441d6fbad879725a [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/support-9a4a5bfe2a031117 [INFO] [stdout] running 0 tests [INFO] [stderr] Running /opt/rustwide/target/debug/deps/test_timer-c405e05f042fa1a3 [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 15 tests [INFO] [stdout] test test_immediate_sleep ... ok [INFO] [stdout] test test_interval_at_past ... ok [INFO] [stdout] test test_timeout_with_future_errors_first ... ok [INFO] [stdout] test test_timeout_with_future_completes_first ... ok [INFO] [stdout] test test_timeout_stream_with_stream_completes_first ... ok [INFO] [stdout] test test_timeout_with_timeout_completes_first ... ok [INFO] [stdout] test test_interval_once ... ok [INFO] [stdout] test test_timeout_stream_with_timeout_completes_first ... ok [INFO] [stdout] test test_request_sleep_greater_than_max ... ok [INFO] [stdout] test test_interval_at_once ... FAILED [INFO] [stdout] test test_setting_later_sleep_then_earlier_one ... ok [INFO] [stdout] test test_interval_twice ... FAILED [INFO] [stdout] test test_interval_at_twice ... ok [INFO] [stdout] test test_timer_with_looping_wheel ... ok [INFO] [stdout] test test_delayed_sleep ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_interval_at_once stdout ---- [INFO] [stdout] thread 'test_interval_at_once' panicked at 'expect=500ms; actual=474.825011ms', tests/support.rs:24:13 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x564fd6cf7770 - std::backtrace_rs::backtrace::libunwind::trace::h04d12fdcddff82aa [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/../../backtrace/src/backtrace/libunwind.rs:100:5 [INFO] [stdout] 1: 0x564fd6cf7770 - std::backtrace_rs::backtrace::trace_unsynchronized::h1459b974b6fbe5e1 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x564fd6cf7770 - std::sys_common::backtrace::_print_fmt::h9b8396a669123d95 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x564fd6cf7770 - ::fmt::he009dcaaa75eed60 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x564fd6d1a9dc - core::fmt::write::h77b4746b0dea1dd3 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/fmt/mod.rs:1078:17 [INFO] [stdout] 5: 0x564fd6c77666 - std::io::Write::write_fmt::h3a40d9c04f88bb58 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/io/mod.rs:1518:15 [INFO] [stdout] 6: 0x564fd6cf16fd - std::io::impls::>::write_fmt::h1b3d263673641f53 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/io/impls.rs:179:9 [INFO] [stdout] 7: 0x564fd6cf9e95 - std::sys_common::backtrace::_print::h2d880c9e69a21be9 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 8: 0x564fd6cf9e95 - std::sys_common::backtrace::print::h5f02b1bb49f36879 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 9: 0x564fd6cf9e95 - std::panicking::default_hook::{{closure}}::h658e288a7a809b29 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:208:50 [INFO] [stdout] 10: 0x564fd6cf9ae2 - std::panicking::default_hook::hb52d73f0da9a4bb8 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:224:9 [INFO] [stdout] 11: 0x564fd6cfa631 - std::panicking::rust_panic_with_hook::hfe7e1c684e3e6462 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:593:17 [INFO] [stdout] 12: 0x564fd6cfa177 - std::panicking::begin_panic_handler::{{closure}}::h42939e004b32765c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:499:13 [INFO] [stdout] 13: 0x564fd6cf7c2c - std::sys_common::backtrace::__rust_end_short_backtrace::h9d2070f7bf9fd56c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:141:18 [INFO] [stdout] 14: 0x564fd6cfa0d9 - rust_begin_unwind [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:495:5 [INFO] [stdout] 15: 0x564fd6cfa08b - std::panicking::begin_panic_fmt::h4a7e15187eac098d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:437:5 [INFO] [stdout] 16: 0x564fd6c6959d - test_timer::support::Elapsed::assert_is_about::h02c5076911393cd5 [INFO] [stdout] at /opt/rustwide/workdir/tests/support.rs:24:13 [INFO] [stdout] 17: 0x564fd6c51b5e - test_timer::test_interval_at_once::hdb2daaf1000a1e22 [INFO] [stdout] at /opt/rustwide/workdir/tests/test_timer.rs:280:5 [INFO] [stdout] 18: 0x564fd6c519ea - test_timer::test_interval_at_once::{{closure}}::hbd111aaf69966316 [INFO] [stdout] at /opt/rustwide/workdir/tests/test_timer.rs:270:1 [INFO] [stdout] 19: 0x564fd6c58dee - core::ops::function::FnOnce::call_once::hea46b8fe57414e6f [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 20: 0x564fd6c9f1b3 - core::ops::function::FnOnce::call_once::hdbd2235b6243db3d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 21: 0x564fd6c9f1b3 - test::__rust_begin_short_backtrace::hb1dea1c208110812 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:517:5 [INFO] [stdout] 22: 0x564fd6c9d65a - as core::ops::function::FnOnce>::call_once::h5d11a40efef721f2 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 23: 0x564fd6c9d65a - as core::ops::function::FnOnce<()>>::call_once::h23961df98af0bc5a [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:322:9 [INFO] [stdout] 24: 0x564fd6c9d65a - std::panicking::try::do_call::h6390646e3de3fb9e [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:381:40 [INFO] [stdout] 25: 0x564fd6c9d65a - std::panicking::try::hc531439ab6159192 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:345:19 [INFO] [stdout] 26: 0x564fd6c9d65a - std::panic::catch_unwind::h859d8bdaf9b4855c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:396:14 [INFO] [stdout] 27: 0x564fd6c9d65a - test::run_test_in_process::hae60aa74417e3abc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:544:18 [INFO] [stdout] 28: 0x564fd6c9d65a - test::run_test::run_test_inner::{{closure}}::hf48c86652c4a151d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:450:39 [INFO] [stdout] 29: 0x564fd6c769e6 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb82b392232b8bd1f [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:125:18 [INFO] [stdout] 30: 0x564fd6c7b9e3 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h79ca9e9abe157956 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/thread/mod.rs:474:17 [INFO] [stdout] 31: 0x564fd6c7b9e3 - as core::ops::function::FnOnce<()>>::call_once::ha12f1f228780a4f7 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:322:9 [INFO] [stdout] 32: 0x564fd6c7b9e3 - std::panicking::try::do_call::h722bb7416d021cdc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:381:40 [INFO] [stdout] 33: 0x564fd6c7b9e3 - std::panicking::try::h78e5abca71ac7cac [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:345:19 [INFO] [stdout] 34: 0x564fd6c7b9e3 - std::panic::catch_unwind::h95162588bd0fa090 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:396:14 [INFO] [stdout] 35: 0x564fd6c7b9e3 - std::thread::Builder::spawn_unchecked::{{closure}}::h64da5c4b9acc58dc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/thread/mod.rs:473:30 [INFO] [stdout] 36: 0x564fd6c7b9e3 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h7a8c588ad0b69edb [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 37: 0x564fd6d00a7a - as core::ops::function::FnOnce>::call_once::h09ff301006f1aeca [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 38: 0x564fd6d00a7a - as core::ops::function::FnOnce>::call_once::he79488c8f00b5f31 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 39: 0x564fd6d00a7a - std::sys::unix::thread::Thread::new::thread_start::h587efff279c68ba7 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys/unix/thread.rs:71:17 [INFO] [stdout] 40: 0x7f6fea159609 - start_thread [INFO] [stdout] 41: 0x7f6fe9f2b293 - clone [INFO] [stdout] 42: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- test_interval_twice stdout ---- [INFO] [stdout] thread 'test_interval_twice' panicked at 'expect=600ms; actual=575.360963ms', tests/support.rs:24:13 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x564fd6cf7770 - std::backtrace_rs::backtrace::libunwind::trace::h04d12fdcddff82aa [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/../../backtrace/src/backtrace/libunwind.rs:100:5 [INFO] [stdout] 1: 0x564fd6cf7770 - std::backtrace_rs::backtrace::trace_unsynchronized::h1459b974b6fbe5e1 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x564fd6cf7770 - std::sys_common::backtrace::_print_fmt::h9b8396a669123d95 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x564fd6cf7770 - ::fmt::he009dcaaa75eed60 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x564fd6d1a9dc - core::fmt::write::h77b4746b0dea1dd3 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/fmt/mod.rs:1078:17 [INFO] [stdout] 5: 0x564fd6c77666 - std::io::Write::write_fmt::h3a40d9c04f88bb58 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/io/mod.rs:1518:15 [INFO] [stdout] 6: 0x564fd6cf16fd - std::io::impls::>::write_fmt::h1b3d263673641f53 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/io/impls.rs:179:9 [INFO] [stdout] 7: 0x564fd6cf9e95 - std::sys_common::backtrace::_print::h2d880c9e69a21be9 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 8: 0x564fd6cf9e95 - std::sys_common::backtrace::print::h5f02b1bb49f36879 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 9: 0x564fd6cf9e95 - std::panicking::default_hook::{{closure}}::h658e288a7a809b29 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:208:50 [INFO] [stdout] 10: 0x564fd6cf9ae2 - std::panicking::default_hook::hb52d73f0da9a4bb8 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:224:9 [INFO] [stdout] 11: 0x564fd6cfa631 - std::panicking::rust_panic_with_hook::hfe7e1c684e3e6462 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:593:17 [INFO] [stdout] 12: 0x564fd6cfa177 - std::panicking::begin_panic_handler::{{closure}}::h42939e004b32765c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:499:13 [INFO] [stdout] 13: 0x564fd6cf7c2c - std::sys_common::backtrace::__rust_end_short_backtrace::h9d2070f7bf9fd56c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:141:18 [INFO] [stdout] 14: 0x564fd6cfa0d9 - rust_begin_unwind [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:495:5 [INFO] [stdout] 15: 0x564fd6cfa08b - std::panicking::begin_panic_fmt::h4a7e15187eac098d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:437:5 [INFO] [stdout] 16: 0x564fd6c6959d - test_timer::support::Elapsed::assert_is_about::h02c5076911393cd5 [INFO] [stdout] at /opt/rustwide/workdir/tests/support.rs:24:13 [INFO] [stdout] 17: 0x564fd6c51944 - test_timer::test_interval_twice::h975e514a2f2f974a [INFO] [stdout] at /opt/rustwide/workdir/tests/test_timer.rs:266:5 [INFO] [stdout] 18: 0x564fd6c5180a - test_timer::test_interval_twice::{{closure}}::h049f43a340922bbb [INFO] [stdout] at /opt/rustwide/workdir/tests/test_timer.rs:256:1 [INFO] [stdout] 19: 0x564fd6c58abe - core::ops::function::FnOnce::call_once::h7a231bb7d6e319dd [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 20: 0x564fd6c9f1b3 - core::ops::function::FnOnce::call_once::hdbd2235b6243db3d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 21: 0x564fd6c9f1b3 - test::__rust_begin_short_backtrace::hb1dea1c208110812 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:517:5 [INFO] [stdout] 22: 0x564fd6c9d65a - as core::ops::function::FnOnce>::call_once::h5d11a40efef721f2 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 23: 0x564fd6c9d65a - as core::ops::function::FnOnce<()>>::call_once::h23961df98af0bc5a [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:322:9 [INFO] [stdout] 24: 0x564fd6c9d65a - std::panicking::try::do_call::h6390646e3de3fb9e [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:381:40 [INFO] [stdout] 25: 0x564fd6c9d65a - std::panicking::try::hc531439ab6159192 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:345:19 [INFO] [stdout] 26: 0x564fd6c9d65a - std::panic::catch_unwind::h859d8bdaf9b4855c [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:396:14 [INFO] [stdout] 27: 0x564fd6c9d65a - test::run_test_in_process::hae60aa74417e3abc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:544:18 [INFO] [stdout] 28: 0x564fd6c9d65a - test::run_test::run_test_inner::{{closure}}::hf48c86652c4a151d [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/test/src/lib.rs:450:39 [INFO] [stdout] 29: 0x564fd6c769e6 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb82b392232b8bd1f [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys_common/backtrace.rs:125:18 [INFO] [stdout] 30: 0x564fd6c7b9e3 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h79ca9e9abe157956 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/thread/mod.rs:474:17 [INFO] [stdout] 31: 0x564fd6c7b9e3 - as core::ops::function::FnOnce<()>>::call_once::ha12f1f228780a4f7 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:322:9 [INFO] [stdout] 32: 0x564fd6c7b9e3 - std::panicking::try::do_call::h722bb7416d021cdc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:381:40 [INFO] [stdout] 33: 0x564fd6c7b9e3 - std::panicking::try::h78e5abca71ac7cac [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panicking.rs:345:19 [INFO] [stdout] 34: 0x564fd6c7b9e3 - std::panic::catch_unwind::h95162588bd0fa090 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/panic.rs:396:14 [INFO] [stdout] 35: 0x564fd6c7b9e3 - std::thread::Builder::spawn_unchecked::{{closure}}::h64da5c4b9acc58dc [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/thread/mod.rs:473:30 [INFO] [stdout] 36: 0x564fd6c7b9e3 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h7a8c588ad0b69edb [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 37: 0x564fd6d00a7a - as core::ops::function::FnOnce>::call_once::h09ff301006f1aeca [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 38: 0x564fd6d00a7a - as core::ops::function::FnOnce>::call_once::he79488c8f00b5f31 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/alloc/src/boxed.rs:1307:9 [INFO] [stdout] 39: 0x564fd6d00a7a - std::sys::unix::thread::Thread::new::thread_start::h587efff279c68ba7 [INFO] [stdout] at /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/std/src/sys/unix/thread.rs:71:17 [INFO] [stdout] 40: 0x7f6fea159609 - start_thread [INFO] [stdout] 41: 0x7f6fe9f2b293 - clone [INFO] [stdout] 42: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_interval_at_once [INFO] [stdout] test_interval_twice [INFO] [stdout] [INFO] [stdout] test result: FAILED. 13 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test test_timer' [INFO] running `Command { std: "docker" "inspect" "967f7e58d2f215441b43db56b3661fcacfea9f34dceb3cd59b6272bfaa5b9534", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "967f7e58d2f215441b43db56b3661fcacfea9f34dceb3cd59b6272bfaa5b9534", kill_on_drop: false }` [INFO] [stdout] 967f7e58d2f215441b43db56b3661fcacfea9f34dceb3cd59b6272bfaa5b9534