Dec 13 15:10:11.578 INFO testing jondot/rawsort against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 15:10:11.582 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 15:10:11.969 INFO [stdout] 84ff16c2d8c23fd15dedc920a99bf00434b1a5f1b15ebe0486b6c319f739b1e4
Dec 13 15:10:11.976 INFO running `"docker" "start" "-a" "84ff16c2d8c23fd15dedc920a99bf00434b1a5f1b15ebe0486b6c319f739b1e4"`
Dec 13 15:10:13.371 INFO [stderr] usermod: no changes
Dec 13 15:10:13.683 INFO [stderr]    Compiling slog v2.3.3
Dec 13 15:10:13.691 INFO [stderr]    Compiling inotify-sys v0.1.3
Dec 13 15:10:13.691 INFO [stderr]    Compiling termios v0.2.2
Dec 13 15:10:13.693 INFO [stderr]    Compiling net2 v0.2.33
Dec 13 15:10:13.693 INFO [stderr]    Compiling filetime v0.2.1
Dec 13 15:10:13.693 INFO [stderr]    Compiling isatty v0.1.9
Dec 13 15:10:13.693 INFO [stderr]    Compiling clicolors-control v0.2.0
Dec 13 15:10:13.693 INFO [stderr]    Compiling bytes v0.4.9
Dec 13 15:10:15.575 INFO [stderr]    Compiling clap v2.32.0
Dec 13 15:10:16.545 INFO [stderr]    Compiling tempfile v2.2.0
Dec 13 15:10:16.545 INFO [stderr]    Compiling regex v0.2.11
Dec 13 15:10:16.575 INFO [stderr]    Compiling parking_lot v0.6.3
Dec 13 15:10:19.379 INFO [stderr]    Compiling slog-json v2.2.0
Dec 13 15:10:19.479 INFO [stderr]    Compiling slog-term v2.4.0
Dec 13 15:10:19.897 INFO [stderr]    Compiling mio v0.6.15
Dec 13 15:10:19.939 INFO [stderr]    Compiling tokio-io v0.1.8
Dec 13 15:10:26.983 INFO [stderr]    Compiling tokio-reactor v0.1.5
Dec 13 15:10:26.983 INFO [stderr]    Compiling mio-extras v2.0.5
Dec 13 15:10:32.391 INFO [stderr]    Compiling console v0.6.1
Dec 13 15:10:33.112 INFO [stderr]    Compiling inotify v0.6.1
Dec 13 15:10:35.791 INFO [stderr]    Compiling notify v4.0.6
Dec 13 15:10:35.959 INFO [stderr]    Compiling dialoguer v0.1.0
Dec 13 15:10:42.510 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Dec 13 15:10:53.192 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.79s
Dec 13 15:10:53.204 INFO [stderr] su: No module specific data is present
Dec 13 15:10:54.421 INFO running `"docker" "inspect" "84ff16c2d8c23fd15dedc920a99bf00434b1a5f1b15ebe0486b6c319f739b1e4"`
Dec 13 15:10:54.821 INFO running `"docker" "rm" "-f" "84ff16c2d8c23fd15dedc920a99bf00434b1a5f1b15ebe0486b6c319f739b1e4"`
Dec 13 15:10:55.211 INFO [stdout] 84ff16c2d8c23fd15dedc920a99bf00434b1a5f1b15ebe0486b6c319f739b1e4
Dec 13 15:10:55.219 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 15:10:55.789 INFO [stdout] 23f7ffc44490ae7ce135e690a07c918f20d753f211ee602d9bccc0f1c94d4793
Dec 13 15:10:55.791 INFO running `"docker" "start" "-a" "23f7ffc44490ae7ce135e690a07c918f20d753f211ee602d9bccc0f1c94d4793"`
Dec 13 15:10:58.193 INFO [stderr] usermod: no changes
Dec 13 15:10:58.479 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Dec 13 15:11:02.685 INFO [stderr] warning: unused variable: `exec`
Dec 13 15:11:02.685 INFO [stderr]    --> tests/integration_test.rs:119:16
Dec 13 15:11:02.685 INFO [stderr]     |
Dec 13 15:11:02.685 INFO [stderr] 119 |     let (plan, exec) = make_plan("simple", "[year]");
Dec 13 15:11:02.685 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Dec 13 15:11:02.686 INFO [stderr]     |
Dec 13 15:11:02.686 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 13 15:11:02.686 INFO [stderr] 
Dec 13 15:11:02.686 INFO [stderr] warning: unused variable: `exec`
Dec 13 15:11:02.686 INFO [stderr]    --> tests/integration_test.rs:138:16
Dec 13 15:11:02.686 INFO [stderr]     |
Dec 13 15:11:02.686 INFO [stderr] 138 |     let (plan, exec) = make_plan(
Dec 13 15:11:02.686 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Dec 13 15:11:02.686 INFO [stderr] 
Dec 13 15:11:06.651 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.42s
Dec 13 15:11:06.663 INFO [stderr] su: No module specific data is present
Dec 13 15:11:08.223 INFO running `"docker" "inspect" "23f7ffc44490ae7ce135e690a07c918f20d753f211ee602d9bccc0f1c94d4793"`
Dec 13 15:11:08.576 INFO running `"docker" "rm" "-f" "23f7ffc44490ae7ce135e690a07c918f20d753f211ee602d9bccc0f1c94d4793"`
Dec 13 15:11:08.817 INFO [stdout] 23f7ffc44490ae7ce135e690a07c918f20d753f211ee602d9bccc0f1c94d4793
Dec 13 15:11:08.823 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 15:11:09.283 INFO [stdout] 825e538563a031ba5a76b6b710eebb5521a858c9e72555f94dfce55a2bf6800f
Dec 13 15:11:09.288 INFO running `"docker" "start" "-a" "825e538563a031ba5a76b6b710eebb5521a858c9e72555f94dfce55a2bf6800f"`
Dec 13 15:11:10.472 INFO [stderr] usermod: no changes
Dec 13 15:11:10.667 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 13 15:11:10.679 INFO [stderr]      Running /target/debug/deps/rawsort-2be67f30b6daa180
Dec 13 15:11:10.682 INFO [stdout] 
Dec 13 15:11:10.682 INFO [stdout] running 0 tests
Dec 13 15:11:10.682 INFO [stdout] 
Dec 13 15:11:10.682 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:11:10.682 INFO [stdout] 
Dec 13 15:11:10.687 INFO [stderr]      Running /target/debug/deps/rawsort-7136880ac4ff9388
Dec 13 15:11:10.693 INFO [stdout] 
Dec 13 15:11:10.694 INFO [stdout] running 0 tests
Dec 13 15:11:10.694 INFO [stdout] 
Dec 13 15:11:10.694 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:11:10.694 INFO [stdout] 
Dec 13 15:11:10.694 INFO [stderr]      Running /target/debug/deps/integration_test-36c5842e952d816f
Dec 13 15:11:10.695 INFO [stdout] 
Dec 13 15:11:10.695 INFO [stdout] running 5 tests
Dec 13 15:11:10.708 INFO [stdout] test it_plans_properly ... ok
Dec 13 15:11:10.729 INFO [stdout] test it_detects_potential_overwrites ... ok
Dec 13 15:11:10.799 INFO [stdout] test it_will_not_format_almost_a_good_format ... ok
Dec 13 15:11:10.804 INFO [stdout] test it_will_format_a_good_format ... ok
Dec 13 15:11:10.804 INFO [stdout] test it_detects_bad_formats ... ok
Dec 13 15:11:10.805 INFO [stdout] 
Dec 13 15:11:10.805 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:11:10.805 INFO [stdout] 
Dec 13 15:11:10.805 INFO [stderr]    Doc-tests rawsort
Dec 13 15:11:13.431 INFO [stdout] 
Dec 13 15:11:13.431 INFO [stdout] running 0 tests
Dec 13 15:11:13.431 INFO [stdout] 
Dec 13 15:11:13.431 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:11:13.431 INFO [stdout] 
Dec 13 15:11:13.450 INFO [stderr] su: No module specific data is present
Dec 13 15:11:14.328 INFO running `"docker" "inspect" "825e538563a031ba5a76b6b710eebb5521a858c9e72555f94dfce55a2bf6800f"`
Dec 13 15:11:14.605 INFO running `"docker" "rm" "-f" "825e538563a031ba5a76b6b710eebb5521a858c9e72555f94dfce55a2bf6800f"`
Dec 13 15:11:14.967 INFO [stdout] 825e538563a031ba5a76b6b710eebb5521a858c9e72555f94dfce55a2bf6800f