Nov 16 23:23:38.244 INFO testing jondot/rawsort against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 23:23:38.246 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:38.793 INFO [stdout] 26d2d6c868543de02c934aa5f21189bfcdac17b27dfd5264e6a24d3ee3b31825
Nov 16 23:23:38.794 INFO running `"docker" "start" "-a" "26d2d6c868543de02c934aa5f21189bfcdac17b27dfd5264e6a24d3ee3b31825"`
Nov 16 23:23:40.515 INFO [stderr] usermod: no changes
Nov 16 23:23:40.903 INFO [stderr]    Compiling slog v2.3.3
Nov 16 23:23:40.903 INFO [stderr]    Compiling kamadak-exif v0.3.1
Nov 16 23:23:40.907 INFO [stderr]    Compiling inotify-sys v0.1.3
Nov 16 23:23:40.907 INFO [stderr]    Compiling termios v0.2.2
Nov 16 23:23:40.907 INFO [stderr]    Compiling net2 v0.2.33
Nov 16 23:23:40.907 INFO [stderr]    Compiling isatty v0.1.9
Nov 16 23:23:40.907 INFO [stderr]    Compiling filetime v0.2.1
Nov 16 23:23:40.927 INFO [stderr]    Compiling clicolors-control v0.2.0
Nov 16 23:23:42.812 INFO [stderr]    Compiling bytes v0.4.9
Nov 16 23:23:44.412 INFO [stderr]    Compiling clap v2.32.0
Nov 16 23:23:44.627 INFO [stderr]    Compiling tempfile v2.2.0
Nov 16 23:23:44.631 INFO [stderr]    Compiling regex v0.2.11
Nov 16 23:23:44.704 INFO [stderr]    Compiling parking_lot v0.6.3
Nov 16 23:23:48.615 INFO [stderr]    Compiling slog-term v2.4.0
Nov 16 23:23:48.615 INFO [stderr]    Compiling slog-json v2.2.0
Nov 16 23:23:48.675 INFO [stderr]    Compiling tokio-io v0.1.8
Nov 16 23:23:51.159 INFO [stderr]    Compiling mio v0.6.15
Nov 16 23:24:02.411 INFO [stderr]    Compiling tokio-reactor v0.1.5
Nov 16 23:24:02.412 INFO [stderr]    Compiling mio-extras v2.0.5
Nov 16 23:24:02.807 INFO [stderr]    Compiling console v0.6.1
Nov 16 23:24:06.223 INFO [stderr]    Compiling dialoguer v0.1.0
Nov 16 23:24:07.655 INFO [stderr]    Compiling inotify v0.6.1
Nov 16 23:24:11.712 INFO [stderr]    Compiling notify v4.0.6
Nov 16 23:24:15.528 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Nov 16 23:24:24.248 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.70s
Nov 16 23:24:24.267 INFO [stderr] su: No module specific data is present
Nov 16 23:24:25.033 INFO running `"docker" "inspect" "26d2d6c868543de02c934aa5f21189bfcdac17b27dfd5264e6a24d3ee3b31825"`
Nov 16 23:24:25.433 INFO running `"docker" "rm" "-f" "26d2d6c868543de02c934aa5f21189bfcdac17b27dfd5264e6a24d3ee3b31825"`
Nov 16 23:24:25.867 INFO [stdout] 26d2d6c868543de02c934aa5f21189bfcdac17b27dfd5264e6a24d3ee3b31825
Nov 16 23:24:25.870 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:26.489 INFO [stdout] e963034751910f5ad763fe3e8255c61a968a6f6285340a31f97b9004aa29eeb1
Nov 16 23:24:26.491 INFO running `"docker" "start" "-a" "e963034751910f5ad763fe3e8255c61a968a6f6285340a31f97b9004aa29eeb1"`
Nov 16 23:24:29.075 INFO [stderr] usermod: no changes
Nov 16 23:24:29.278 INFO [stderr]    Compiling rawsort v0.3.1-alpha.0 (/source)
Nov 16 23:24:32.963 INFO [stderr] warning: unused variable: `exec`
Nov 16 23:24:32.963 INFO [stderr]    --> tests/integration_test.rs:119:16
Nov 16 23:24:32.963 INFO [stderr]     |
Nov 16 23:24:32.963 INFO [stderr] 119 |     let (plan, exec) = make_plan("simple", "[year]");
Nov 16 23:24:32.963 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Nov 16 23:24:32.963 INFO [stderr]     |
Nov 16 23:24:32.963 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 23:24:32.963 INFO [stderr] 
Nov 16 23:24:32.963 INFO [stderr] warning: unused variable: `exec`
Nov 16 23:24:32.963 INFO [stderr]    --> tests/integration_test.rs:138:16
Nov 16 23:24:32.963 INFO [stderr]     |
Nov 16 23:24:32.963 INFO [stderr] 138 |     let (plan, exec) = make_plan(
Nov 16 23:24:32.963 INFO [stderr]     |                ^^^^ help: consider using `_exec` instead
Nov 16 23:24:32.963 INFO [stderr] 
Nov 16 23:24:36.160 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.07s
Nov 16 23:24:36.183 INFO [stderr] su: No module specific data is present
Nov 16 23:24:36.983 INFO running `"docker" "inspect" "e963034751910f5ad763fe3e8255c61a968a6f6285340a31f97b9004aa29eeb1"`
Nov 16 23:24:37.144 INFO running `"docker" "rm" "-f" "e963034751910f5ad763fe3e8255c61a968a6f6285340a31f97b9004aa29eeb1"`
Nov 16 23:24:37.282 INFO [stdout] e963034751910f5ad763fe3e8255c61a968a6f6285340a31f97b9004aa29eeb1
Nov 16 23:24:37.285 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:37.548 INFO [stdout] ca21dcd4c1beb83541f89e14a3e2ae68aa562646c7033edc1c99df8dd43a6653
Nov 16 23:24:37.550 INFO running `"docker" "start" "-a" "ca21dcd4c1beb83541f89e14a3e2ae68aa562646c7033edc1c99df8dd43a6653"`
Nov 16 23:24:38.102 INFO [stderr] usermod: no changes
Nov 16 23:24:38.248 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Nov 16 23:24:38.254 INFO [stderr]      Running /target/debug/deps/rawsort-d914c7e275061f8a
Nov 16 23:24:38.258 INFO [stdout] 
Nov 16 23:24:38.258 INFO [stdout] running 0 tests
Nov 16 23:24:38.258 INFO [stdout] 
Nov 16 23:24:38.258 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:38.258 INFO [stdout] 
Nov 16 23:24:38.259 INFO [stderr]      Running /target/debug/deps/rawsort-a9a8cb9aaa1b8760
Nov 16 23:24:38.261 INFO [stdout] 
Nov 16 23:24:38.261 INFO [stdout] running 0 tests
Nov 16 23:24:38.261 INFO [stdout] 
Nov 16 23:24:38.261 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:38.261 INFO [stdout] 
Nov 16 23:24:38.261 INFO [stderr]      Running /target/debug/deps/integration_test-4d1f529a7e7e360e
Nov 16 23:24:38.264 INFO [stdout] 
Nov 16 23:24:38.264 INFO [stdout] running 5 tests
Nov 16 23:24:38.273 INFO [stdout] test it_detects_potential_overwrites ... ok
Nov 16 23:24:38.281 INFO [stdout] test it_plans_properly ... ok
Nov 16 23:24:38.305 INFO [stdout] test it_detects_bad_formats ... ok
Nov 16 23:24:38.320 INFO [stdout] test it_will_not_format_almost_a_good_format ... ok
Nov 16 23:24:38.331 INFO [stderr]    Doc-tests rawsort
Nov 16 23:24:38.331 INFO [stdout] test it_will_format_a_good_format ... ok
Nov 16 23:24:38.331 INFO [stdout] 
Nov 16 23:24:38.331 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:38.331 INFO [stdout] 
Nov 16 23:24:40.116 INFO [stdout] 
Nov 16 23:24:40.116 INFO [stdout] running 0 tests
Nov 16 23:24:40.119 INFO [stdout] 
Nov 16 23:24:40.119 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:24:40.119 INFO [stdout] 
Nov 16 23:24:40.127 INFO [stderr] su: No module specific data is present
Nov 16 23:24:40.467 INFO running `"docker" "inspect" "ca21dcd4c1beb83541f89e14a3e2ae68aa562646c7033edc1c99df8dd43a6653"`
Nov 16 23:24:40.650 INFO running `"docker" "rm" "-f" "ca21dcd4c1beb83541f89e14a3e2ae68aa562646c7033edc1c99df8dd43a6653"`
Nov 16 23:24:40.879 INFO [stdout] ca21dcd4c1beb83541f89e14a3e2ae68aa562646c7033edc1c99df8dd43a6653