Nov 16 23:23:28.731 INFO testing jondot/rawsort against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 23:23:28.731 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 23:23:29.373 INFO [stdout] 690d739cb70efdcfcadf6ecc2eb38430bd02e270b74118a3cc32ced859051582
Nov 16 23:23:29.375 INFO running `"docker" "start" "-a" "690d739cb70efdcfcadf6ecc2eb38430bd02e270b74118a3cc32ced859051582"`
Nov 16 23:23:31.675 INFO [stderr] usermod: no changes
Nov 16 23:23:32.031 INFO [stderr]    Compiling kamadak-exif v0.3.1
Nov 16 23:23:32.031 INFO [stderr]    Compiling inotify-sys v0.1.3
Nov 16 23:23:32.039 INFO [stderr]    Compiling net2 v0.2.33
Nov 16 23:23:32.055 INFO [stderr]    Compiling filetime v0.2.1
Nov 16 23:23:32.055 INFO [stderr]    Compiling isatty v0.1.9
Nov 16 23:23:32.055 INFO [stderr]    Compiling bytes v0.4.9
Nov 16 23:23:32.055 INFO [stderr]    Compiling parking_lot v0.6.3
Nov 16 23:23:32.055 INFO [stderr]    Compiling slog-json v2.2.0
Nov 16 23:23:33.723 INFO [stderr]    Compiling slog-term v2.4.0
Nov 16 23:23:36.216 INFO [stderr]    Compiling mio v0.6.15
Nov 16 23:23:36.919 INFO [stderr]    Compiling tokio-io v0.1.8
Nov 16 23:23:39.415 INFO [stderr]    Compiling console v0.6.1
Nov 16 23:23:44.020 INFO [stderr]    Compiling tokio-reactor v0.1.5
Nov 16 23:23:44.021 INFO [stderr]    Compiling mio-extras v2.0.5
Nov 16 23:23:46.007 INFO [stderr]    Compiling dialoguer v0.1.0
Nov 16 23:23:48.983 INFO [stderr]    Compiling inotify v0.6.1
Nov 16 23:23:51.083 INFO [stderr]    Compiling notify v4.0.6
Nov 16 23:23:57.059 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Nov 16 23:24:08.485 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 36.79s
Nov 16 23:24:08.500 INFO [stderr] su: No module specific data is present
Nov 16 23:24:09.514 INFO running `"docker" "inspect" "690d739cb70efdcfcadf6ecc2eb38430bd02e270b74118a3cc32ced859051582"`
Nov 16 23:24:09.819 INFO running `"docker" "rm" "-f" "690d739cb70efdcfcadf6ecc2eb38430bd02e270b74118a3cc32ced859051582"`
Nov 16 23:24:10.095 INFO [stdout] 690d739cb70efdcfcadf6ecc2eb38430bd02e270b74118a3cc32ced859051582
Nov 16 23:24:10.096 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 23:24:10.561 INFO [stdout] 41dce24bc9c942762131055c7bc420639207832e696a7a00aa1c1bc40a24ef5e
Nov 16 23:24:10.569 INFO running `"docker" "start" "-a" "41dce24bc9c942762131055c7bc420639207832e696a7a00aa1c1bc40a24ef5e"`
Nov 16 23:24:11.595 INFO [stderr] usermod: no changes
Nov 16 23:24:11.752 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Nov 16 23:24:13.183 INFO [stderr] warning: unused variable: `exec`
Nov 16 23:24:13.183 INFO [stderr]    --> tests/integration_test.rs:119:16
Nov 16 23:24:13.183 INFO [stderr]     |
Nov 16 23:24:13.183 INFO [stderr] 119 |     let (plan, exec) = make_plan("simple", "[year]");
Nov 16 23:24:13.183 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Nov 16 23:24:13.183 INFO [stderr]     |
Nov 16 23:24:13.184 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 23:24:13.184 INFO [stderr] 
Nov 16 23:24:13.184 INFO [stderr] warning: unused variable: `exec`
Nov 16 23:24:13.184 INFO [stderr]    --> tests/integration_test.rs:138:16
Nov 16 23:24:13.184 INFO [stderr]     |
Nov 16 23:24:13.184 INFO [stderr] 138 |     let (plan, exec) = make_plan(
Nov 16 23:24:13.184 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Nov 16 23:24:13.184 INFO [stderr] 
Nov 16 23:24:15.668 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.05s
Nov 16 23:24:15.691 INFO [stderr] su: No module specific data is present
Nov 16 23:24:16.320 INFO running `"docker" "inspect" "41dce24bc9c942762131055c7bc420639207832e696a7a00aa1c1bc40a24ef5e"`
Nov 16 23:24:16.484 INFO running `"docker" "rm" "-f" "41dce24bc9c942762131055c7bc420639207832e696a7a00aa1c1bc40a24ef5e"`
Nov 16 23:24:16.655 INFO [stdout] 41dce24bc9c942762131055c7bc420639207832e696a7a00aa1c1bc40a24ef5e
Nov 16 23:24:16.659 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 23:24:17.155 INFO [stdout] 87c940cf7cd9f5481e175b98b4c42035a48b74335f73d20d1380e3b598b0cfbd
Nov 16 23:24:17.159 INFO running `"docker" "start" "-a" "87c940cf7cd9f5481e175b98b4c42035a48b74335f73d20d1380e3b598b0cfbd"`
Nov 16 23:24:17.819 INFO [stderr] usermod: no changes
Nov 16 23:24:17.914 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 16 23:24:17.919 INFO [stderr]      Running /target/debug/deps/rawsort-3ee64066a1767d2a
Nov 16 23:24:17.920 INFO [stdout] 
Nov 16 23:24:17.920 INFO [stdout] running 0 tests
Nov 16 23:24:17.920 INFO [stdout] 
Nov 16 23:24:17.920 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:17.920 INFO [stdout] 
Nov 16 23:24:17.921 INFO [stderr]      Running /target/debug/deps/rawsort-0c5af64ed512d0c4
Nov 16 23:24:17.922 INFO [stdout] 
Nov 16 23:24:17.922 INFO [stdout] running 0 tests
Nov 16 23:24:17.922 INFO [stdout] 
Nov 16 23:24:17.922 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:17.922 INFO [stdout] 
Nov 16 23:24:17.923 INFO [stderr]      Running /target/debug/deps/integration_test-e273772e1cbf3de4
Nov 16 23:24:17.924 INFO [stdout] 
Nov 16 23:24:17.925 INFO [stdout] running 5 tests
Nov 16 23:24:17.927 INFO [stdout] test it_plans_properly ... ok
Nov 16 23:24:17.928 INFO [stdout] test it_detects_potential_overwrites ... ok
Nov 16 23:24:17.959 INFO [stdout] test it_detects_bad_formats ... ok
Nov 16 23:24:17.963 INFO [stdout] test it_will_format_a_good_format ... ok
Nov 16 23:24:17.970 INFO [stdout] test it_will_not_format_almost_a_good_format ... ok
Nov 16 23:24:17.971 INFO [stdout] 
Nov 16 23:24:17.971 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:17.971 INFO [stdout] 
Nov 16 23:24:17.975 INFO [stderr]    Doc-tests rawsort
Nov 16 23:24:19.994 INFO [stdout] 
Nov 16 23:24:19.994 INFO [stdout] running 0 tests
Nov 16 23:24:19.994 INFO [stdout] 
Nov 16 23:24:19.994 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:19.994 INFO [stdout] 
Nov 16 23:24:20.005 INFO [stderr] su: No module specific data is present
Nov 16 23:24:20.899 INFO running `"docker" "inspect" "87c940cf7cd9f5481e175b98b4c42035a48b74335f73d20d1380e3b598b0cfbd"`
Nov 16 23:24:21.244 INFO running `"docker" "rm" "-f" "87c940cf7cd9f5481e175b98b4c42035a48b74335f73d20d1380e3b598b0cfbd"`
Nov 16 23:24:21.587 INFO [stdout] 87c940cf7cd9f5481e175b98b4c42035a48b74335f73d20d1380e3b598b0cfbd