Dec 01 13:35:43.965 INFO testing jondot/rawsort against 1.30.1 for beta-1.31-5
Dec 01 13:35:43.965 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 13:35:44.488 INFO [stdout] 7cae2b823622c59903b74994b05184f0bc4839c4290065d80dae09a694323c6d
Dec 01 13:35:44.490 INFO running `"docker" "start" "-a" "7cae2b823622c59903b74994b05184f0bc4839c4290065d80dae09a694323c6d"`
Dec 01 13:35:45.463 INFO [stderr] usermod: no changes
Dec 01 13:35:45.819 INFO [stderr]    Compiling slog v2.3.3
Dec 01 13:35:45.819 INFO [stderr]    Compiling kamadak-exif v0.3.1
Dec 01 13:35:45.827 INFO [stderr]    Compiling inotify-sys v0.1.3
Dec 01 13:35:45.831 INFO [stderr]    Compiling net2 v0.2.33
Dec 01 13:35:45.835 INFO [stderr]    Compiling filetime v0.2.1
Dec 01 13:35:45.835 INFO [stderr]    Compiling isatty v0.1.9
Dec 01 13:35:45.835 INFO [stderr]    Compiling bytes v0.4.9
Dec 01 13:35:45.835 INFO [stderr]    Compiling clap v2.32.0
Dec 01 13:35:48.683 INFO [stderr]    Compiling tempfile v2.2.0
Dec 01 13:35:48.731 INFO [stderr]    Compiling regex v0.2.11
Dec 01 13:35:51.983 INFO [stderr]    Compiling slog-term v2.4.0
Dec 01 13:35:52.023 INFO [stderr]    Compiling slog-json v2.2.0
Dec 01 13:35:52.043 INFO [stderr]    Compiling mio v0.6.15
Dec 01 13:35:56.439 INFO [stderr]    Compiling tokio-io v0.1.8
Dec 01 13:36:00.823 INFO [stderr]    Compiling mio-extras v2.0.5
Dec 01 13:36:04.659 INFO [stderr]    Compiling tokio-reactor v0.1.5
Dec 01 13:36:14.775 INFO [stderr]    Compiling console v0.6.1
Dec 01 13:36:14.888 INFO [stderr]    Compiling inotify v0.6.1
Dec 01 13:36:22.527 INFO [stderr]    Compiling dialoguer v0.1.0
Dec 01 13:36:22.619 INFO [stderr]    Compiling notify v4.0.6
Dec 01 13:36:29.283 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Dec 01 13:36:39.312 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 53.81s
Dec 01 13:36:39.327 INFO [stderr] su: No module specific data is present
Dec 01 13:36:40.069 INFO running `"docker" "inspect" "7cae2b823622c59903b74994b05184f0bc4839c4290065d80dae09a694323c6d"`
Dec 01 13:36:40.393 INFO running `"docker" "rm" "-f" "7cae2b823622c59903b74994b05184f0bc4839c4290065d80dae09a694323c6d"`
Dec 01 13:36:40.657 INFO [stdout] 7cae2b823622c59903b74994b05184f0bc4839c4290065d80dae09a694323c6d
Dec 01 13:36:40.660 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 13:36:41.251 INFO [stdout] 28a9af053d7ef787ba3a029c731c45018b9356045ea2067c64022778fe9a0298
Dec 01 13:36:41.253 INFO running `"docker" "start" "-a" "28a9af053d7ef787ba3a029c731c45018b9356045ea2067c64022778fe9a0298"`
Dec 01 13:36:42.767 INFO [stderr] usermod: no changes
Dec 01 13:36:42.944 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Dec 01 13:36:46.035 INFO [stderr] warning: unused variable: `exec`
Dec 01 13:36:46.035 INFO [stderr]    --> tests/integration_test.rs:119:16
Dec 01 13:36:46.035 INFO [stderr]     |
Dec 01 13:36:46.035 INFO [stderr] 119 |     let (plan, exec) = make_plan("simple", "[year]");
Dec 01 13:36:46.035 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Dec 01 13:36:46.035 INFO [stderr]     |
Dec 01 13:36:46.035 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 01 13:36:46.035 INFO [stderr] 
Dec 01 13:36:46.035 INFO [stderr] warning: unused variable: `exec`
Dec 01 13:36:46.035 INFO [stderr]    --> tests/integration_test.rs:138:16
Dec 01 13:36:46.035 INFO [stderr]     |
Dec 01 13:36:46.035 INFO [stderr] 138 |     let (plan, exec) = make_plan(
Dec 01 13:36:46.035 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Dec 01 13:36:46.035 INFO [stderr] 
Dec 01 13:36:49.097 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.30s
Dec 01 13:36:49.114 INFO [stderr] su: No module specific data is present
Dec 01 13:36:49.690 INFO running `"docker" "inspect" "28a9af053d7ef787ba3a029c731c45018b9356045ea2067c64022778fe9a0298"`
Dec 01 13:36:49.933 INFO running `"docker" "rm" "-f" "28a9af053d7ef787ba3a029c731c45018b9356045ea2067c64022778fe9a0298"`
Dec 01 13:36:50.142 INFO [stdout] 28a9af053d7ef787ba3a029c731c45018b9356045ea2067c64022778fe9a0298
Dec 01 13:36:50.153 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 13:36:50.627 INFO [stdout] efcf4ee99c07da249c499698ea2fce03c74645a8b937353924d999cf4893b3b2
Dec 01 13:36:50.630 INFO running `"docker" "start" "-a" "efcf4ee99c07da249c499698ea2fce03c74645a8b937353924d999cf4893b3b2"`
Dec 01 13:36:51.337 INFO [stderr] usermod: no changes
Dec 01 13:36:51.486 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 01 13:36:51.507 INFO [stderr]      Running /target/debug/deps/rawsort-60c721226c7eb646
Dec 01 13:36:51.507 INFO [stderr]      Running /target/debug/deps/rawsort-ddcf27989406cfb3
Dec 01 13:36:51.507 INFO [stdout] 
Dec 01 13:36:51.507 INFO [stdout] running 0 tests
Dec 01 13:36:51.507 INFO [stdout] 
Dec 01 13:36:51.507 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 13:36:51.507 INFO [stdout] 
Dec 01 13:36:51.514 INFO [stderr]      Running /target/debug/deps/integration_test-68cecc48586cc114
Dec 01 13:36:51.514 INFO [stdout] 
Dec 01 13:36:51.514 INFO [stdout] running 0 tests
Dec 01 13:36:51.514 INFO [stdout] 
Dec 01 13:36:51.514 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 13:36:51.514 INFO [stdout] 
Dec 01 13:36:51.520 INFO [stdout] 
Dec 01 13:36:51.520 INFO [stdout] running 5 tests
Dec 01 13:36:51.527 INFO [stdout] test it_plans_properly ... ok
Dec 01 13:36:51.538 INFO [stdout] test it_detects_potential_overwrites ... ok
Dec 01 13:36:51.631 INFO [stdout] test it_will_format_a_good_format ... ok
Dec 01 13:36:51.650 INFO [stdout] test it_detects_bad_formats ... ok
Dec 01 13:36:51.650 INFO [stdout] test it_will_not_format_almost_a_good_format ... ok
Dec 01 13:36:51.650 INFO [stdout] 
Dec 01 13:36:51.650 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 13:36:51.651 INFO [stdout] 
Dec 01 13:36:51.653 INFO [stderr]    Doc-tests rawsort
Dec 01 13:36:54.351 INFO [stdout] 
Dec 01 13:36:54.351 INFO [stdout] running 0 tests
Dec 01 13:36:54.351 INFO [stdout] 
Dec 01 13:36:54.351 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 13:36:54.351 INFO [stdout] 
Dec 01 13:36:54.371 INFO [stderr] su: No module specific data is present
Dec 01 13:36:55.369 INFO running `"docker" "inspect" "efcf4ee99c07da249c499698ea2fce03c74645a8b937353924d999cf4893b3b2"`
Dec 01 13:36:55.663 INFO running `"docker" "rm" "-f" "efcf4ee99c07da249c499698ea2fce03c74645a8b937353924d999cf4893b3b2"`
Dec 01 13:36:55.952 INFO [stdout] efcf4ee99c07da249c499698ea2fce03c74645a8b937353924d999cf4893b3b2
