Nov 17 02:25:16.578 INFO testing gadomski/riprocess against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 02:25:16.579 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 02:25:17.046 INFO [stdout] 8df788f0976bdc8d97627fb2242862f87240497251236689994aa3084414c73e
Nov 17 02:25:17.053 INFO running `"docker" "start" "-a" "8df788f0976bdc8d97627fb2242862f87240497251236689994aa3084414c73e"`
Nov 17 02:25:18.270 INFO [stderr] usermod: no changes
Nov 17 02:25:18.378 INFO [stderr]    Compiling libc v0.2.30
Nov 17 02:25:19.623 INFO [stderr]    Compiling memchr v1.0.1
Nov 17 02:25:20.339 INFO [stderr]    Compiling aho-corasick v0.6.3
Nov 17 02:25:21.615 INFO [stderr]    Compiling regex v0.2.2
Nov 17 02:25:31.028 INFO [stderr]    Compiling docopt v0.8.1
Nov 17 02:25:37.536 INFO [stderr]    Compiling riprocess v0.1.0 (/source)
Nov 17 02:25:44.335 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 26.04s
Nov 17 02:25:44.343 INFO [stderr] su: No module specific data is present
Nov 17 02:25:45.927 INFO running `"docker" "inspect" "8df788f0976bdc8d97627fb2242862f87240497251236689994aa3084414c73e"`
Nov 17 02:25:46.221 INFO running `"docker" "rm" "-f" "8df788f0976bdc8d97627fb2242862f87240497251236689994aa3084414c73e"`
Nov 17 02:25:46.467 INFO [stdout] 8df788f0976bdc8d97627fb2242862f87240497251236689994aa3084414c73e
Nov 17 02:25:46.477 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 02:25:47.101 INFO [stdout] dfb55f6f609414bc9eae6e5073003ee13b60b507fe083882149f1418699dd2e6
Nov 17 02:25:47.104 INFO running `"docker" "start" "-a" "dfb55f6f609414bc9eae6e5073003ee13b60b507fe083882149f1418699dd2e6"`
Nov 17 02:25:48.591 INFO [stderr] usermod: no changes
Nov 17 02:25:48.711 INFO [stderr]    Compiling riprocess v0.1.0 (/source)
Nov 17 02:25:53.460 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.84s
Nov 17 02:25:53.464 INFO [stderr] su: No module specific data is present
Nov 17 02:25:54.242 INFO running `"docker" "inspect" "dfb55f6f609414bc9eae6e5073003ee13b60b507fe083882149f1418699dd2e6"`
Nov 17 02:25:54.561 INFO running `"docker" "rm" "-f" "dfb55f6f609414bc9eae6e5073003ee13b60b507fe083882149f1418699dd2e6"`
Nov 17 02:25:54.867 INFO [stdout] dfb55f6f609414bc9eae6e5073003ee13b60b507fe083882149f1418699dd2e6
Nov 17 02:25:54.874 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 02:25:55.338 INFO [stdout] 9d9bd6cc7bbf5c23021817529d4877f9dfddf0fab82a5ef16ffd81bb17814255
Nov 17 02:25:55.341 INFO running `"docker" "start" "-a" "9d9bd6cc7bbf5c23021817529d4877f9dfddf0fab82a5ef16ffd81bb17814255"`
Nov 17 02:25:56.434 INFO [stderr] usermod: no changes
Nov 17 02:25:56.525 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 17 02:25:56.543 INFO [stderr]      Running /target/debug/deps/riprocess-2ce116b9049f251e
Nov 17 02:25:56.544 INFO [stdout] 
Nov 17 02:25:56.544 INFO [stdout] running 20 tests
Nov 17 02:25:56.563 INFO [stdout] test image::tests::all_images ... ok
Nov 17 02:25:56.563 INFO [stdout] test image::tests::end ... ok
Nov 17 02:25:56.563 INFO [stdout] test image::tests::end_out_of_range ... ok
Nov 17 02:25:56.571 INFO [stdout] test image::tests::no_images ... ok
Nov 17 02:25:56.573 INFO [stdout] test image::tests::start ... ok
Nov 17 02:25:56.573 INFO [stdout] test record::tests::from_reference ... ok
Nov 17 02:25:56.573 INFO [stdout] test record::tests::count_mismatch ... ok
Nov 17 02:25:56.591 INFO [stdout] test record::tests::empty_timestamps ... ok
Nov 17 02:25:56.606 INFO [stdout] test config::tests::no_images ... ok
Nov 17 02:25:56.607 INFO [stdout] test config::tests::image_count_mismatch ... ok
Nov 17 02:25:56.607 INFO [stdout] test config::tests::image_list ... ok
Nov 17 02:25:56.607 INFO [stdout] test config::tests::record_count_mismatch ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::end ... ok
Nov 17 02:25:56.607 INFO [stdout] test image::tests::start_out_of_range ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::invalid_end ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::all_paths ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::timestamps ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::start ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::no_paths ... ok
Nov 17 02:25:56.607 INFO [stdout] test timestamp::tests::invalid_start ... ok
Nov 17 02:25:56.607 INFO [stdout] 
Nov 17 02:25:56.607 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 02:25:56.607 INFO [stdout] 
Nov 17 02:25:56.619 INFO [stderr]    Doc-tests riprocess
Nov 17 02:25:57.564 INFO [stdout] 
Nov 17 02:25:57.564 INFO [stdout] running 10 tests
Nov 17 02:26:00.327 INFO [stdout] test src/record.rs - record::Config::adjust_timestamps (line 20) ... ok
Nov 17 02:26:08.177 INFO [stdout] test src/config.rs - config::Config::new (line 62) ... ok
Nov 17 02:26:09.354 INFO [stdout] test src/image.rs - image::Config::new (line 35) ... ok
Nov 17 02:26:09.873 INFO [stdout] test src/image.rs - image::Config::paths (line 50) ... ok
Nov 17 02:26:10.414 INFO [stdout] test src/record.rs - record::Config::adjust_timestamps (line 39) ... ok
Nov 17 02:26:12.479 INFO [stdout] test src/timestamp.rs - timestamp::Config::paths (line 34) ... ok
Nov 17 02:26:12.659 INFO [stdout] test src/config.rs - config::Config (line 10) ... ok
Nov 17 02:26:12.851 INFO [stdout] test src/config.rs - config::Config::from_path (line 44) ... ok
Nov 17 02:26:12.943 INFO [stdout] test src/config.rs - config::Config::image_list (line 77) ... ok
Nov 17 02:26:14.187 INFO [stdout] test src/timestamp.rs - timestamp::Config::timestamps (line 82) ... ok
Nov 17 02:26:14.187 INFO [stdout] 
Nov 17 02:26:14.187 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 02:26:14.187 INFO [stdout] 
Nov 17 02:26:14.243 INFO [stderr] su: No module specific data is present
Nov 17 02:26:15.393 INFO running `"docker" "inspect" "9d9bd6cc7bbf5c23021817529d4877f9dfddf0fab82a5ef16ffd81bb17814255"`
Nov 17 02:26:15.727 INFO running `"docker" "rm" "-f" "9d9bd6cc7bbf5c23021817529d4877f9dfddf0fab82a5ef16ffd81bb17814255"`
Nov 17 02:26:16.063 INFO [stdout] 9d9bd6cc7bbf5c23021817529d4877f9dfddf0fab82a5ef16ffd81bb17814255