[INFO] cloning repository https://github.com/vladneyo/timetrap [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/vladneyo/timetrap" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fvladneyo%2Ftimetrap", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fvladneyo%2Ftimetrap'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 3e3f77d303de1f398c12b2f443906e10a10b2d6a [INFO] testing vladneyo/timetrap against beta-2025-04-13 for beta-1.87-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fvladneyo%2Ftimetrap" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/vladneyo/timetrap on toolchain beta-2025-04-13 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-04-13" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/vladneyo/timetrap [INFO] finished tweaking git repo https://github.com/vladneyo/timetrap [INFO] tweaked toml for git repo https://github.com/vladneyo/timetrap written to /workspace/builds/worker-7-tc2/source/Cargo.toml [INFO] crate git repo https://github.com/vladneyo/timetrap 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" "+beta-2025-04-13" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 6248d9301740394dd45251d648a34407c5878d395ca1fa8534efa3a077aabcf3 [INFO] running `Command { std: "docker" "start" "-a" "6248d9301740394dd45251d648a34407c5878d395ca1fa8534efa3a077aabcf3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "6248d9301740394dd45251d648a34407c5878d395ca1fa8534efa3a077aabcf3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6248d9301740394dd45251d648a34407c5878d395ca1fa8534efa3a077aabcf3", kill_on_drop: false }` [INFO] [stdout] 6248d9301740394dd45251d648a34407c5878d395ca1fa8534efa3a077aabcf3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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" "RUSTDOCFLAGS=--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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e09b7a4cb4c04938dad1702cd2ea99ef77bd564ddf2a3ca0809b6b3eec95ea99 [INFO] running `Command { std: "docker" "start" "-a" "e09b7a4cb4c04938dad1702cd2ea99ef77bd564ddf2a3ca0809b6b3eec95ea99", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.171 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling sysinfo v0.34.1 [INFO] [stderr] Compiling timetrap v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.71s [INFO] running `Command { std: "docker" "inspect" "e09b7a4cb4c04938dad1702cd2ea99ef77bd564ddf2a3ca0809b6b3eec95ea99", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e09b7a4cb4c04938dad1702cd2ea99ef77bd564ddf2a3ca0809b6b3eec95ea99", kill_on_drop: false }` [INFO] [stdout] e09b7a4cb4c04938dad1702cd2ea99ef77bd564ddf2a3ca0809b6b3eec95ea99 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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" "RUSTDOCFLAGS=--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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 95475c78b6553a2b588c9da444a2c18390a0da78bc8ef78e683839d48d71ff04 [INFO] running `Command { std: "docker" "start" "-a" "95475c78b6553a2b588c9da444a2c18390a0da78bc8ef78e683839d48d71ff04", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.4.0 [INFO] [stderr] Compiling proc-macro2 v1.0.94 [INFO] [stderr] Compiling unicode-ident v1.0.18 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling smallvec v1.14.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling predicates-core v1.0.9 [INFO] [stderr] Compiling mockall_derive v0.13.1 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling termtree v0.5.1 [INFO] [stderr] Compiling anstyle v1.0.10 [INFO] [stderr] Compiling predicates-tree v1.0.12 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling lock_api v0.4.12 [INFO] [stderr] Compiling predicates v3.1.3 [INFO] [stderr] Compiling lazy_static v1.5.0 [INFO] [stderr] Compiling downcast v0.11.0 [INFO] [stderr] Compiling fragile v2.0.1 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling dashmap v5.5.3 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling serial_test_derive v2.0.0 [INFO] [stderr] Compiling serial_test v2.0.0 [INFO] [stderr] Compiling mockall v0.13.1 [INFO] [stderr] Compiling timetrap v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 19.99s [INFO] running `Command { std: "docker" "inspect" "95475c78b6553a2b588c9da444a2c18390a0da78bc8ef78e683839d48d71ff04", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "95475c78b6553a2b588c9da444a2c18390a0da78bc8ef78e683839d48d71ff04", kill_on_drop: false }` [INFO] [stdout] 95475c78b6553a2b588c9da444a2c18390a0da78bc8ef78e683839d48d71ff04 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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" "RUSTDOCFLAGS=--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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] afc938274d9114712cf64e3d4382ba5286ea39039e1451584547b8d8450c3a92 [INFO] running `Command { std: "docker" "start" "-a" "afc938274d9114712cf64e3d4382ba5286ea39039e1451584547b8d8450c3a92", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/timetrap-bcaadc6fd46d2539) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test tests::trap_mem_tests::trap_mem_named_method_returns_value ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_fn_called_once_and_returns_value ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_expr_returns_value ... ok [INFO] [stdout] test tests::trap_tests::trap_expr_returns_value ... ok [INFO] [stdout] test tests::trap_tests::trap_expr_works ... ok [INFO] [stdout] test tests::trap_tests::trap_fn_called_once_and_returns_value ... ok [INFO] [stdout] test tests::trap_tests::trap_fn_called_once_and_works ... ok [INFO] [stdout] test tests::trap_tests::trap_named_method_returns_value ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_expr_works ... ok [INFO] [stdout] test tests::trap_tests::trap_named_method_works ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_fn_called_once_and_works ... FAILED [INFO] [stdout] test tests::trap_mem_tests::trap_mem_named_method_works ... FAILED [INFO] [stdout] test tests::trap_mem_tests::trap_mem_fn_called_once_and_returns_hashmap ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_set_mb ... ok [INFO] [stdout] test tests::trap_mem_tests::trap_mem_set_kb ... ok [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] [stdout] test tests::trap_mem_tests::trap_mem_named_method_returns_hashmap ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::trap_mem_tests::trap_mem_fn_called_once_and_works stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'tests::trap_mem_tests::trap_mem_fn_called_once_and_works' panicked at src/tests/trap_mem_tests.rs:171:1: [INFO] [stdout] MockTestEntity::test_method(): No matching expectation found [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d20e233ab82 - std::backtrace_rs::backtrace::libunwind::trace::h97da83aab53f337d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d20e233ab82 - std::backtrace_rs::backtrace::trace_unsynchronized::h07d9fad959b0b0c4 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d20e233ab82 - std::sys::backtrace::_print_fmt::h73b6844d523a91e6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5d20e233ab82 - ::fmt::had50d3dbab4f9a49 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5d20e23621c3 - core::fmt::rt::Argument::fmt::h96dc2668ac588484 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/rt.rs:184:76 [INFO] [stdout] 5: 0x5d20e23621c3 - core::fmt::write::h3c068850dd3fcd11 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/mod.rs:1480:21 [INFO] [stdout] 6: 0x5d20e2338053 - std::io::default_write_fmt::h9f5cac5e26eafb82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5d20e2338053 - std::io::Write::write_fmt::h9be88ac981c80255 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x5d20e233a9d2 - std::sys::backtrace::BacktraceLock::print::h160d33c700b1accf [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x5d20e233bf6c - std::panicking::default_hook::{{closure}}::hdccf862335980e92 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x5d20e233bdc2 - std::panicking::default_hook::h92ea296b4f4c5d78 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x5d20e22a6b14 - as core::ops::function::Fn>::call::h58e2cb0c3aa8f900 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x5d20e22a6b14 - test::test_main::{{closure}}::h068e739b3ff3ace9 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:136:21 [INFO] [stdout] 13: 0x5d20e233c9e3 - as core::ops::function::Fn>::call::h4dc3b8e0d98a0945 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x5d20e233c9e3 - std::panicking::rust_panic_with_hook::h53eb519a340d7090 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x5d20e233c6ba - std::panicking::begin_panic_handler::{{closure}}::h1b012222d781940d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:706:13 [INFO] [stdout] 16: 0x5d20e233b079 - std::sys::backtrace::__rust_end_short_backtrace::hb1c00a6a74936045 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x5d20e233c34d - __rustc[3fad54a3e94379e3]::rust_begin_unwind [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x5d20e2244110 - core::panicking::panic_fmt::h5646b0c12be1dead [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x5d20e22440eb - core::panicking::panic_display::h6329d1ae72613c25 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panicking.rs:261:5 [INFO] [stdout] 20: 0x5d20e22440eb - core::option::expect_failed::ha170c4993b004e51 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/option.rs:2024:5 [INFO] [stdout] 21: 0x5d20e224c310 - core::option::Option::expect::hed553794a89ef019 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/option.rs:933:21 [INFO] [stdout] 22: 0x5d20e226241b - timetrap::tests::trap_mem_tests::MockTestEntity::test_method::hdfb6903b66f9c304 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:171:1 [INFO] [stdout] 23: 0x5d20e225ef16 - timetrap::tests::trap_mem_tests::trap_mem_fn_called_once_and_works::{{closure}}::h9ba1fdfb894d6516 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:18:28 [INFO] [stdout] 24: 0x5d20e226580d - timetrap::measure_time::h11052b3c824e1402 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:82:18 [INFO] [stdout] 25: 0x5d20e2268a6d - timetrap::measure_time_and_memory::h55ecbc61d3a4cc82 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:112:18 [INFO] [stdout] 26: 0x5d20e225ee84 - timetrap::tests::trap_mem_tests::trap_mem_fn_called_once_and_works::h4bca369c94943970 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:73:21 [INFO] [stdout] 27: 0x5d20e225edc7 - timetrap::tests::trap_mem_tests::trap_mem_fn_called_once_and_works::{{closure}}::h29ce3da5ae5b2000 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:12:39 [INFO] [stdout] 28: 0x5d20e2249b56 - core::ops::function::FnOnce::call_once::ha34a1b8f08073e64 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 29: 0x5d20e22ac46b - core::ops::function::FnOnce::call_once::h36fc4a9de3ab6dc6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 30: 0x5d20e22ac46b - test::__rust_begin_short_backtrace::ha0a98bb69b358a31 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:638:18 [INFO] [stdout] 31: 0x5d20e22ab45f - test::run_test_in_process::{{closure}}::h8c178d13fba0a588 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:60 [INFO] [stdout] 32: 0x5d20e22ab45f - as core::ops::function::FnOnce<()>>::call_once::hcf9a13e44c998160 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 33: 0x5d20e22ab45f - std::panicking::try::do_call::h4af5be696220e430 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 34: 0x5d20e22ab45f - std::panicking::try::hbf49a526ff439d5e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 35: 0x5d20e22ab45f - std::panic::catch_unwind::h73db1b343ad1c705 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 36: 0x5d20e22ab45f - test::run_test_in_process::hef059ed743ea6437 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:27 [INFO] [stdout] 37: 0x5d20e22ab45f - test::run_test::{{closure}}::h9508bce7fbf1ad82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:582:43 [INFO] [stdout] 38: 0x5d20e226fbb4 - test::run_test::{{closure}}::h70f94fa995999514 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:612:41 [INFO] [stdout] 39: 0x5d20e226fbb4 - std::sys::backtrace::__rust_begin_short_backtrace::hfc7043e7c8324aca [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 40: 0x5d20e22734aa - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h599c966db81290c0 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 41: 0x5d20e22734aa - as core::ops::function::FnOnce<()>>::call_once::h499078bec004bb56 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 42: 0x5d20e22734aa - std::panicking::try::do_call::h336d5bb945571c50 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 43: 0x5d20e22734aa - std::panicking::try::hea8a9a2c11807957 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 44: 0x5d20e22734aa - std::panic::catch_unwind::hc46631a6d929f68d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 45: 0x5d20e22734aa - std::thread::Builder::spawn_unchecked_::{{closure}}::he5729da5506c58d1 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 46: 0x5d20e22734aa - core::ops::function::FnOnce::call_once{{vtable.shim}}::h8b7f1215a4f7e46f [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x5d20e233e7cb - as core::ops::function::FnOnce>::call_once::h5e2c5a5b1d7d1d9c [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 48: 0x5d20e233e7cb - as core::ops::function::FnOnce>::call_once::hc50cd23acd01680e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 49: 0x5d20e233e7cb - std::sys::pal::unix::thread::Thread::new::thread_start::hb3d0e19f380baa62 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/pal/unix/thread.rs:109:17 [INFO] [stdout] 50: 0x7879ed412aa4 - [INFO] [stdout] 51: 0x7879ed49fa34 - clone [INFO] [stdout] 52: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- tests::trap_mem_tests::trap_mem_named_method_works stdout ---- [INFO] [stdout] test_method took 8.97µs [INFO] [stdout] test_method consumed memory: -5816320.00Bytes [INFO] [stdout] test_method consumed swap: 0.00Bytes [INFO] [stdout] [INFO] [stdout] thread 'tests::trap_mem_tests::trap_mem_named_method_works' panicked at src/tests/trap_mem_tests.rs:171:1: [INFO] [stdout] MockTestEntity::test_method: Expectation() called 0 time(s) which is fewer than expected 1 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d20e233ab82 - std::backtrace_rs::backtrace::libunwind::trace::h97da83aab53f337d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d20e233ab82 - std::backtrace_rs::backtrace::trace_unsynchronized::h07d9fad959b0b0c4 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d20e233ab82 - std::sys::backtrace::_print_fmt::h73b6844d523a91e6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5d20e233ab82 - ::fmt::had50d3dbab4f9a49 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5d20e23621c3 - core::fmt::rt::Argument::fmt::h96dc2668ac588484 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/rt.rs:184:76 [INFO] [stdout] 5: 0x5d20e23621c3 - core::fmt::write::h3c068850dd3fcd11 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/mod.rs:1480:21 [INFO] [stdout] 6: 0x5d20e2338053 - std::io::default_write_fmt::h9f5cac5e26eafb82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5d20e2338053 - std::io::Write::write_fmt::h9be88ac981c80255 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x5d20e233a9d2 - std::sys::backtrace::BacktraceLock::print::h160d33c700b1accf [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x5d20e233bf6c - std::panicking::default_hook::{{closure}}::hdccf862335980e92 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x5d20e233bdc2 - std::panicking::default_hook::h92ea296b4f4c5d78 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x5d20e22a6b14 - as core::ops::function::Fn>::call::h58e2cb0c3aa8f900 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x5d20e22a6b14 - test::test_main::{{closure}}::h068e739b3ff3ace9 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:136:21 [INFO] [stdout] 13: 0x5d20e233c9e3 - as core::ops::function::Fn>::call::h4dc3b8e0d98a0945 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x5d20e233c9e3 - std::panicking::rust_panic_with_hook::h53eb519a340d7090 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x5d20e233c6ba - std::panicking::begin_panic_handler::{{closure}}::h1b012222d781940d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:706:13 [INFO] [stdout] 16: 0x5d20e233b079 - std::sys::backtrace::__rust_end_short_backtrace::hb1c00a6a74936045 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x5d20e233c34d - __rustc[3fad54a3e94379e3]::rust_begin_unwind [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x5d20e2244110 - core::panicking::panic_fmt::h5646b0c12be1dead [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x5d20e2257a4f - ::drop::h2befb7b0854ee141 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:171:1 [INFO] [stdout] 20: 0x5d20e224bc93 - core::ptr::drop_in_place::hf2afae9248d07e0a [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 21: 0x5d20e2249fd3 - core::ptr::drop_in_place::h3430d50b1edc1482 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 22: 0x5d20e224a489 - core::ptr::drop_in_place<[timetrap::tests::trap_mem_tests::__mock_MockTestEntity::__test_method::Expectation]>::h0c1d422154338aaf [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 23: 0x5d20e22485e2 - as core::ops::drop::Drop>::drop::hd466c5cf3f9385fa [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/vec/mod.rs:3798:13 [INFO] [stdout] 24: 0x5d20e224aa93 - core::ptr::drop_in_place>::h6b79b7ec9cecf9d8 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 25: 0x5d20e22587e0 - timetrap::tests::trap_mem_tests::__mock_MockTestEntity::__test_method::Context::do_checkpoint::ha1b2ab1c5e329024 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:171:11 [INFO] [stdout] 26: 0x5d20e2258907 - ::drop::hbd58eb04c633b3bc [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:171:1 [INFO] [stdout] 27: 0x5d20e224bd0a - core::ptr::drop_in_place::h4aaf41b5e710061f [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 28: 0x5d20e225f066 - timetrap::tests::trap_mem_tests::trap_mem_named_method_works::h092af8eecf2a2f2a [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:35:1 [INFO] [stdout] 29: 0x5d20e225ef37 - timetrap::tests::trap_mem_tests::trap_mem_named_method_works::{{closure}}::hb49e02d11bb6698a [INFO] [stdout] at /opt/rustwide/workdir/src/tests/trap_mem_tests.rs:25:33 [INFO] [stdout] 30: 0x5d20e2249f16 - core::ops::function::FnOnce::call_once::hf10a0e0f2107be05 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 31: 0x5d20e22ac46b - core::ops::function::FnOnce::call_once::h36fc4a9de3ab6dc6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 32: 0x5d20e22ac46b - test::__rust_begin_short_backtrace::ha0a98bb69b358a31 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:638:18 [INFO] [stdout] 33: 0x5d20e22ab45f - test::run_test_in_process::{{closure}}::h8c178d13fba0a588 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:60 [INFO] [stdout] 34: 0x5d20e22ab45f - as core::ops::function::FnOnce<()>>::call_once::hcf9a13e44c998160 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 35: 0x5d20e22ab45f - std::panicking::try::do_call::h4af5be696220e430 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 36: 0x5d20e22ab45f - std::panicking::try::hbf49a526ff439d5e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 37: 0x5d20e22ab45f - std::panic::catch_unwind::h73db1b343ad1c705 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 38: 0x5d20e22ab45f - test::run_test_in_process::hef059ed743ea6437 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:27 [INFO] [stdout] 39: 0x5d20e22ab45f - test::run_test::{{closure}}::h9508bce7fbf1ad82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:582:43 [INFO] [stdout] 40: 0x5d20e226fbb4 - test::run_test::{{closure}}::h70f94fa995999514 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:612:41 [INFO] [stdout] 41: 0x5d20e226fbb4 - std::sys::backtrace::__rust_begin_short_backtrace::hfc7043e7c8324aca [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 42: 0x5d20e22734aa - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h599c966db81290c0 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 43: 0x5d20e22734aa - as core::ops::function::FnOnce<()>>::call_once::h499078bec004bb56 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 44: 0x5d20e22734aa - std::panicking::try::do_call::h336d5bb945571c50 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 45: 0x5d20e22734aa - std::panicking::try::hea8a9a2c11807957 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 46: 0x5d20e22734aa - std::panic::catch_unwind::hc46631a6d929f68d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 47: 0x5d20e22734aa - std::thread::Builder::spawn_unchecked_::{{closure}}::he5729da5506c58d1 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 48: 0x5d20e22734aa - core::ops::function::FnOnce::call_once{{vtable.shim}}::h8b7f1215a4f7e46f [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 49: 0x5d20e233e7cb - as core::ops::function::FnOnce>::call_once::h5e2c5a5b1d7d1d9c [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 50: 0x5d20e233e7cb - as core::ops::function::FnOnce>::call_once::hc50cd23acd01680e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 51: 0x5d20e233e7cb - std::sys::pal::unix::thread::Thread::new::thread_start::hb3d0e19f380baa62 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/pal/unix/thread.rs:109:17 [INFO] [stdout] 52: 0x7879ed412aa4 - [INFO] [stdout] 53: 0x7879ed49fa34 - clone [INFO] [stdout] 54: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::trap_mem_tests::trap_mem_fn_called_once_and_works [INFO] [stdout] tests::trap_mem_tests::trap_mem_named_method_works [INFO] [stdout] [INFO] [stdout] test result: FAILED. 14 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.86s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "afc938274d9114712cf64e3d4382ba5286ea39039e1451584547b8d8450c3a92", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "afc938274d9114712cf64e3d4382ba5286ea39039e1451584547b8d8450c3a92", kill_on_drop: false }` [INFO] [stdout] afc938274d9114712cf64e3d4382ba5286ea39039e1451584547b8d8450c3a92