[INFO] cloning repository https://github.com/dyllandry/rust-focus-stopwatch [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dyllandry/rust-focus-stopwatch" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdyllandry%2Frust-focus-stopwatch", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdyllandry%2Frust-focus-stopwatch'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] f533714e4bf874db44e1f97ea50ffdb07d540043 [INFO] testing dyllandry/rust-focus-stopwatch against master#0d162b25edd5bf0dba9a22e83b614f1113e90474 for pr-150681-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdyllandry%2Frust-focus-stopwatch" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/dyllandry/rust-focus-stopwatch [INFO] finished tweaking git repo https://github.com/dyllandry/rust-focus-stopwatch [INFO] tweaked toml for git repo https://github.com/dyllandry/rust-focus-stopwatch written to /workspace/builds/worker-7-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/dyllandry/rust-focus-stopwatch on toolchain 0d162b25edd5bf0dba9a22e83b614f1113e90474 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/dyllandry/rust-focus-stopwatch 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" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded signal-hook-mio v0.2.3 [INFO] [stderr] Downloaded unicode-width v0.1.9 [INFO] [stderr] Downloaded crossterm_winapi v0.9.0 [INFO] [stderr] Downloaded redox_syscall v0.2.13 [INFO] [stderr] Downloaded signal-hook v0.3.14 [INFO] [stderr] Downloaded crossterm v0.23.2 [INFO] [stderr] Downloaded unicode-segmentation v1.9.0 [INFO] [stderr] Downloaded tui v0.18.0 [INFO] [stderr] Downloaded libc v0.2.126 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e2d51bc6a42f09f3fb269d827621db76f7cb8d93b60ae884d482599eba7db7b1 [INFO] running `Command { std: "docker" "start" "-a" "e2d51bc6a42f09f3fb269d827621db76f7cb8d93b60ae884d482599eba7db7b1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e2d51bc6a42f09f3fb269d827621db76f7cb8d93b60ae884d482599eba7db7b1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e2d51bc6a42f09f3fb269d827621db76f7cb8d93b60ae884d482599eba7db7b1", kill_on_drop: false }` [INFO] [stdout] e2d51bc6a42f09f3fb269d827621db76f7cb8d93b60ae884d482599eba7db7b1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c296fe9dc28e35fc17df59471492b0f4064306df30b1e0963bb4dfe5c4ab444d [INFO] running `Command { std: "docker" "start" "-a" "c296fe9dc28e35fc17df59471492b0f4064306df30b1e0963bb4dfe5c4ab444d", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.126 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling signal-hook v0.3.14 [INFO] [stderr] Compiling parking_lot_core v0.9.3 [INFO] [stderr] Compiling smallvec v1.9.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling unicode-segmentation v1.9.0 [INFO] [stderr] Compiling unicode-width v0.1.9 [INFO] [stderr] Compiling cassowary v0.3.0 [INFO] [stderr] Compiling lock_api v0.4.7 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling mio v0.8.4 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling signal-hook-mio v0.2.3 [INFO] [stderr] Compiling crossterm v0.23.2 [INFO] [stderr] Compiling tui v0.18.0 [INFO] [stderr] Compiling rust-focus-stopwatch v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.16s [INFO] running `Command { std: "docker" "inspect" "c296fe9dc28e35fc17df59471492b0f4064306df30b1e0963bb4dfe5c4ab444d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c296fe9dc28e35fc17df59471492b0f4064306df30b1e0963bb4dfe5c4ab444d", kill_on_drop: false }` [INFO] [stdout] c296fe9dc28e35fc17df59471492b0f4064306df30b1e0963bb4dfe5c4ab444d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 32278104f821f28a3e7ab937f7520376170c39c609b8ca645a8739241a928fae [INFO] running `Command { std: "docker" "start" "-a" "32278104f821f28a3e7ab937f7520376170c39c609b8ca645a8739241a928fae", kill_on_drop: false }` [INFO] [stderr] Compiling rust-focus-stopwatch v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.70s [INFO] running `Command { std: "docker" "inspect" "32278104f821f28a3e7ab937f7520376170c39c609b8ca645a8739241a928fae", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "32278104f821f28a3e7ab937f7520376170c39c609b8ca645a8739241a928fae", kill_on_drop: false }` [INFO] [stdout] 32278104f821f28a3e7ab937f7520376170c39c609b8ca645a8739241a928fae [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+0d162b25edd5bf0dba9a22e83b614f1113e90474" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 96040a27708f12d7b9403707beb17cb5c41c274401eb706e029717cd7a645386 [INFO] running `Command { std: "docker" "start" "-a" "96040a27708f12d7b9403707beb17cb5c41c274401eb706e029717cd7a645386", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rust_focus_stopwatch-908b8d0ad6d1269c) [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test tests::app_is_in_focus_mode_given_app_start_up ... ok [INFO] [stdout] test tests::session_time_increases_given_time_passes ... ok [INFO] [stdout] test tests::session_type_total_time_does_not_increase_given_it_is_paused ... ok [INFO] [stdout] test tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted ... FAILED [INFO] [stdout] test tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted stdout ---- [INFO] [stdout] [src/main.rs:439:9] duration.as_millis() = 3 [INFO] [stdout] [INFO] [stdout] thread 'tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted' (29) panicked at src/main.rs:440:9: [INFO] [stdout] assertion failed: duration.as_millis() == 2 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x6264f9a59e62 - std[3b51380354919863]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x6264f9a59e62 - std[3b51380354919863]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x6264f9a59e62 - std[3b51380354919863]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x6264f9a59e62 - <::print::DisplayBacktrace as core[27de1724e4349be2]::fmt::Display>::fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x6264f9a6ecba - ::fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x6264f9a6ecba - core[27de1724e4349be2]::fmt::write [INFO] [stdout] 6: 0x6264f9a5ec66 - std[3b51380354919863]::io::default_write_fmt::> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x6264f9a5ec66 - as std[3b51380354919863]::io::Write>::write_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x6264f9a3852f - ::print [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x6264f9a3852f - std[3b51380354919863]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x6264f9a52079 - std[3b51380354919863]::panicking::default_hook [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x6264f99ea4ee - core[27de1724e4349be2]::ops::function::Fn<(&'a std[3b51380354919863]::panic::PanicHookInfo<'b>,), Output = ()> + core[27de1724e4349be2]::marker::Sync + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::Fn<(&std[3b51380354919863]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x6264f99ea4ee - test[182b2e79ecd7bbd9]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x6264f9a52232 - core[27de1724e4349be2]::ops::function::Fn<(&'a std[3b51380354919863]::panic::PanicHookInfo<'b>,), Output = ()> + core[27de1724e4349be2]::marker::Sync + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::Fn<(&std[3b51380354919863]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x6264f9a52232 - std[3b51380354919863]::panicking::panic_with_hook [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x6264f9a3861a - std[3b51380354919863]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:691:13 [INFO] [stdout] 16: 0x6264f9a2d869 - std[3b51380354919863]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x6264f9a3943d - __rustc[d79c0ace40940972]::rust_begin_unwind [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x6264f9a6f32c - core[27de1724e4349be2]::panicking::panic_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x6264f9a6f2f2 - core[27de1724e4349be2]::panicking::panic [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panicking.rs:150:5 [INFO] [stdout] 20: 0x6264f99dd1ba - rust_focus_stopwatch[2ebdda1a554ec3b7]::tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:440:9 [INFO] [stdout] 21: 0x6264f99db957 - rust_focus_stopwatch[2ebdda1a554ec3b7]::tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:428:82 [INFO] [stdout] 22: 0x6264f99de7b6 - >::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x6264f99de89b - core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x6264f99de89b - test[182b2e79ecd7bbd9]::__rust_begin_short_backtrace::, fn() -> core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:663:18 [INFO] [stdout] 25: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:686:74 [INFO] [stdout] 26: 0x6264f99eb0fa - as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 27: 0x6264f99eb0fa - std[3b51380354919863]::panicking::catch_unwind::do_call::, core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:581:40 [INFO] [stdout] 28: 0x6264f99eb0fa - std[3b51380354919863]::panicking::catch_unwind::, core[27de1724e4349be2]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:544:19 [INFO] [stdout] 29: 0x6264f99eb0fa - std[3b51380354919863]::panic::catch_unwind::, core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panic.rs:359:14 [INFO] [stdout] 30: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test_in_process [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:686:27 [INFO] [stdout] 31: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:607:43 [INFO] [stdout] 32: 0x6264f99e66a4 - test[182b2e79ecd7bbd9]::run_test::{closure#1} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:637:41 [INFO] [stdout] 33: 0x6264f99e66a4 - std[3b51380354919863]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 34: 0x6264f99edbf2 - std[3b51380354919863]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 35: 0x6264f99edbf2 - ::{closure#1}::{closure#0}> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 36: 0x6264f99edbf2 - std[3b51380354919863]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:581:40 [INFO] [stdout] 37: 0x6264f99edbf2 - std[3b51380354919863]::panicking::catch_unwind::<(), core[27de1724e4349be2]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:544:19 [INFO] [stdout] 38: 0x6264f99edbf2 - std[3b51380354919863]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panic.rs:359:14 [INFO] [stdout] 39: 0x6264f99edbf2 - std[3b51380354919863]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 40: 0x6264f99edbf2 - ::{closure#1} as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x6264f9a5970f - + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 42: 0x6264f9a5970f - ::new::thread_start [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/thread/unix.rs:119:17 [INFO] [stdout] 43: 0x75e0465ccaa4 - [INFO] [stdout] 44: 0x75e046659a64 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing' (27) panicked at src/main.rs:464:9: [INFO] [stdout] assertion failed: duration.as_millis() == 1 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x6264f9a59e62 - std[3b51380354919863]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x6264f9a59e62 - std[3b51380354919863]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x6264f9a59e62 - std[3b51380354919863]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x6264f9a59e62 - <::print::DisplayBacktrace as core[27de1724e4349be2]::fmt::Display>::fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x6264f9a6ecba - ::fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x6264f9a6ecba - core[27de1724e4349be2]::fmt::write [INFO] [stdout] 6: 0x6264f9a5ec66 - std[3b51380354919863]::io::default_write_fmt::> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x6264f9a5ec66 - as std[3b51380354919863]::io::Write>::write_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x6264f9a3852f - ::print [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x6264f9a3852f - std[3b51380354919863]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x6264f9a52079 - std[3b51380354919863]::panicking::default_hook [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x6264f99ea4ee - core[27de1724e4349be2]::ops::function::Fn<(&'a std[3b51380354919863]::panic::PanicHookInfo<'b>,), Output = ()> + core[27de1724e4349be2]::marker::Sync + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::Fn<(&std[3b51380354919863]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x6264f99ea4ee - test[182b2e79ecd7bbd9]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x6264f9a52232 - core[27de1724e4349be2]::ops::function::Fn<(&'a std[3b51380354919863]::panic::PanicHookInfo<'b>,), Output = ()> + core[27de1724e4349be2]::marker::Sync + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::Fn<(&std[3b51380354919863]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x6264f9a52232 - std[3b51380354919863]::panicking::panic_with_hook [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x6264f9a3861a - std[3b51380354919863]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:691:13 [INFO] [stdout] 16: 0x6264f9a2d869 - std[3b51380354919863]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x6264f9a3943d - __rustc[d79c0ace40940972]::rust_begin_unwind [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x6264f9a6f32c - core[27de1724e4349be2]::panicking::panic_fmt [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x6264f9a6f2f2 - core[27de1724e4349be2]::panicking::panic [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panicking.rs:150:5 [INFO] [stdout] 20: 0x6264f99dd384 - rust_focus_stopwatch[2ebdda1a554ec3b7]::tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:464:9 [INFO] [stdout] 21: 0x6264f99db987 - rust_focus_stopwatch[2ebdda1a554ec3b7]::tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:454:101 [INFO] [stdout] 22: 0x6264f99de7f6 - >::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x6264f99de89b - core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x6264f99de89b - test[182b2e79ecd7bbd9]::__rust_begin_short_backtrace::, fn() -> core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:663:18 [INFO] [stdout] 25: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:686:74 [INFO] [stdout] 26: 0x6264f99eb0fa - as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 27: 0x6264f99eb0fa - std[3b51380354919863]::panicking::catch_unwind::do_call::, core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:581:40 [INFO] [stdout] 28: 0x6264f99eb0fa - std[3b51380354919863]::panicking::catch_unwind::, core[27de1724e4349be2]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:544:19 [INFO] [stdout] 29: 0x6264f99eb0fa - std[3b51380354919863]::panic::catch_unwind::, core[27de1724e4349be2]::result::Result<(), alloc[a57f19327c0ad893]::string::String>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panic.rs:359:14 [INFO] [stdout] 30: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test_in_process [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:686:27 [INFO] [stdout] 31: 0x6264f99eb0fa - test[182b2e79ecd7bbd9]::run_test::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:607:43 [INFO] [stdout] 32: 0x6264f99e66a4 - test[182b2e79ecd7bbd9]::run_test::{closure#1} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/test/src/lib.rs:637:41 [INFO] [stdout] 33: 0x6264f99e66a4 - std[3b51380354919863]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 34: 0x6264f99edbf2 - std[3b51380354919863]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 35: 0x6264f99edbf2 - ::{closure#1}::{closure#0}> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 36: 0x6264f99edbf2 - std[3b51380354919863]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:581:40 [INFO] [stdout] 37: 0x6264f99edbf2 - std[3b51380354919863]::panicking::catch_unwind::<(), core[27de1724e4349be2]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panicking.rs:544:19 [INFO] [stdout] 38: 0x6264f99edbf2 - std[3b51380354919863]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/panic.rs:359:14 [INFO] [stdout] 39: 0x6264f99edbf2 - std[3b51380354919863]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 40: 0x6264f99edbf2 - ::{closure#1} as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x6264f9a5970f - + core[27de1724e4349be2]::marker::Send> as core[27de1724e4349be2]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 42: 0x6264f9a5970f - ::new::thread_start [INFO] [stdout] at /rustc/0d162b25edd5bf0dba9a22e83b614f1113e90474/library/std/src/sys/thread/unix.rs:119:17 [INFO] [stdout] 43: 0x75e0465ccaa4 - [INFO] [stdout] 44: 0x75e046659a64 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::session_type_total_time_does_not_increase_given_a_different_session_type_time_is_increasing [INFO] [stdout] tests::session_type_total_time_keeps_increases_given_being_paused_and_restarted [INFO] [stdout] [INFO] [stdout] test result: FAILED. 3 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--bin rust-focus-stopwatch` [INFO] running `Command { std: "docker" "inspect" "96040a27708f12d7b9403707beb17cb5c41c274401eb706e029717cd7a645386", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "96040a27708f12d7b9403707beb17cb5c41c274401eb706e029717cd7a645386", kill_on_drop: false }` [INFO] [stdout] 96040a27708f12d7b9403707beb17cb5c41c274401eb706e029717cd7a645386