Nov 17 05:01:55.198 INFO testing deifactor/clockwork-mage against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 05:01:55.199 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 17 05:01:55.856 INFO [stdout] c3d19667b4d44a2de9ccc3025703a1290527e36dbdeb0f448980aa7990683dc9
Nov 17 05:01:55.859 INFO running `"docker" "start" "-a" "c3d19667b4d44a2de9ccc3025703a1290527e36dbdeb0f448980aa7990683dc9"`
Nov 17 05:01:58.031 INFO [stderr] usermod: no changes
Nov 17 05:01:58.317 INFO [stderr]    Compiling slog-scope v4.0.1
Nov 17 05:01:58.318 INFO [stderr]    Compiling syn v0.15.8
Nov 17 05:01:58.335 INFO [stderr]    Compiling structopt-derive v0.2.10
Nov 17 05:01:58.336 INFO [stderr]    Compiling slog-async v2.3.0
Nov 17 05:01:58.336 INFO [stderr]    Compiling slog-term v2.4.0
Nov 17 05:01:58.339 INFO [stderr]    Compiling slog-kvfilter v0.7.0
Nov 17 05:02:01.885 INFO [stderr]    Compiling slog-stdlog v3.0.2
Nov 17 05:02:13.802 INFO [stderr]    Compiling structopt v0.2.10
Nov 17 05:02:22.785 INFO [stderr]    Compiling trackable_derive v0.1.1
Nov 17 05:02:22.785 INFO [stderr]    Compiling serde_derive v1.0.79
Nov 17 05:02:28.444 INFO [stderr]    Compiling trackable v0.2.20
Nov 17 05:02:44.708 INFO [stderr]    Compiling sloggers v0.3.0
Nov 17 05:02:50.425 INFO [stderr]    Compiling clockwork-mage v0.1.0 (/source)
Nov 17 05:02:54.427 INFO [stderr] warning: field is never used: `target`
Nov 17 05:02:54.427 INFO [stderr]   --> src/simulator.rs:14:5
Nov 17 05:02:54.428 INFO [stderr]    |
Nov 17 05:02:54.428 INFO [stderr] 14 |     target: Target,
Nov 17 05:02:54.428 INFO [stderr]    |     ^^^^^^^^^^^^^^
Nov 17 05:02:54.429 INFO [stderr]    |
Nov 17 05:02:54.429 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 17 05:02:54.429 INFO [stderr] 
Nov 17 05:02:54.429 INFO [stderr] warning: method is never used: `event_log`
Nov 17 05:02:54.430 INFO [stderr]   --> src/simulator.rs:49:5
Nov 17 05:02:54.430 INFO [stderr]    |
Nov 17 05:02:54.430 INFO [stderr] 49 |     pub fn event_log(&self) -> &Vec<Event> {
Nov 17 05:02:54.430 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 17 05:02:54.431 INFO [stderr] 
Nov 17 05:02:57.708 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 59.63s
Nov 17 05:02:57.717 INFO [stderr] su: No module specific data is present
Nov 17 05:02:59.208 INFO running `"docker" "inspect" "c3d19667b4d44a2de9ccc3025703a1290527e36dbdeb0f448980aa7990683dc9"`
Nov 17 05:02:59.583 INFO running `"docker" "rm" "-f" "c3d19667b4d44a2de9ccc3025703a1290527e36dbdeb0f448980aa7990683dc9"`
Nov 17 05:02:59.839 INFO [stdout] c3d19667b4d44a2de9ccc3025703a1290527e36dbdeb0f448980aa7990683dc9
Nov 17 05:02:59.848 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 17 05:03:00.404 INFO [stdout] 7f7321d13777c971f03be55f5b8db7755e032abbe6ba7f20597b1dcc6e835499
Nov 17 05:03:00.407 INFO running `"docker" "start" "-a" "7f7321d13777c971f03be55f5b8db7755e032abbe6ba7f20597b1dcc6e835499"`
Nov 17 05:03:01.895 INFO [stderr] usermod: no changes
Nov 17 05:03:02.059 INFO [stderr]    Compiling clockwork-mage v0.1.0 (/source)
Nov 17 05:03:04.589 INFO [stderr] warning: field is never used: `target`
Nov 17 05:03:04.589 INFO [stderr]   --> src/simulator.rs:14:5
Nov 17 05:03:04.589 INFO [stderr]    |
Nov 17 05:03:04.589 INFO [stderr] 14 |     target: Target,
Nov 17 05:03:04.589 INFO [stderr]    |     ^^^^^^^^^^^^^^
Nov 17 05:03:04.589 INFO [stderr]    |
Nov 17 05:03:04.589 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 17 05:03:04.589 INFO [stderr] 
Nov 17 05:03:06.461 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.53s
Nov 17 05:03:06.471 INFO [stderr] su: No module specific data is present
Nov 17 05:03:06.994 INFO running `"docker" "inspect" "7f7321d13777c971f03be55f5b8db7755e032abbe6ba7f20597b1dcc6e835499"`
Nov 17 05:03:07.262 INFO running `"docker" "rm" "-f" "7f7321d13777c971f03be55f5b8db7755e032abbe6ba7f20597b1dcc6e835499"`
Nov 17 05:03:07.551 INFO [stdout] 7f7321d13777c971f03be55f5b8db7755e032abbe6ba7f20597b1dcc6e835499
Nov 17 05:03:07.557 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 17 05:03:08.053 INFO [stdout] 84ad1192a1ac8a27998fd1213aea69b5b2239044da87b5ece41531b6c2ce1b64
Nov 17 05:03:08.057 INFO running `"docker" "start" "-a" "84ad1192a1ac8a27998fd1213aea69b5b2239044da87b5ece41531b6c2ce1b64"`
Nov 17 05:03:09.442 INFO [stderr] usermod: no changes
Nov 17 05:03:09.659 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 17 05:03:09.659 INFO [stderr]      Running /target/debug/deps/clockwork_mage-57102e87f63ab488
Nov 17 05:03:09.691 INFO [stdout] 
Nov 17 05:03:09.691 INFO [stdout] running 15 tests
Nov 17 05:03:09.695 INFO [stdout] test player::tests::starts_unlocked ... ok
Nov 17 05:03:09.695 INFO [stdout] test player::tests::mp_deducted_on_finish ... ok
Nov 17 05:03:09.695 INFO [stdout] test player::tests::starts_locked_after_gcd ... ok
Nov 17 05:03:09.695 INFO [stdout] test simulator::tests::can_begin_on_same_tick_as_perform ... ok
Nov 17 05:03:09.695 INFO [stdout] test rotation::tests::repeat_takes_locks_into_account ... ok
Nov 17 05:03:09.695 INFO [stdout] test rotation::tests::repeat ... ok
Nov 17 05:03:09.695 INFO [stdout] test rotation::tests::empty ... ok
Nov 17 05:03:09.695 INFO [stdout] test time::tests::test_duration_minus_duration ... ok
Nov 17 05:03:09.695 INFO [stdout] test time::tests::test_timestamp_minus_duration ... ok
Nov 17 05:03:09.695 INFO [stdout] test time::tests::test_timestamp_minus_timestamp ... ok
Nov 17 05:03:09.701 INFO [stdout] test player::tests::unlock_timer ... ok
Nov 17 05:03:09.701 INFO [stdout] test time::tests::test_clock ... ok
Nov 17 05:03:09.701 INFO [stdout] test simulator::tests::starts_at_zero ... ok
Nov 17 05:03:09.701 INFO [stdout] test time::tests::test_add ... ok
Nov 17 05:03:09.701 INFO [stdout] test time::tests::test_add_assign ... ok
Nov 17 05:03:09.701 INFO [stdout] 
Nov 17 05:03:09.701 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 05:03:09.701 INFO [stdout] 
Nov 17 05:03:09.707 INFO [stderr] su: No module specific data is present
Nov 17 05:03:10.861 INFO running `"docker" "inspect" "84ad1192a1ac8a27998fd1213aea69b5b2239044da87b5ece41531b6c2ce1b64"`
Nov 17 05:03:11.137 INFO running `"docker" "rm" "-f" "84ad1192a1ac8a27998fd1213aea69b5b2239044da87b5ece41531b6c2ce1b64"`
Nov 17 05:03:11.431 INFO [stdout] 84ad1192a1ac8a27998fd1213aea69b5b2239044da87b5ece41531b6c2ce1b64