Dec 05 05:15:27.642 INFO testing tari/warcdedupe against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 05:15:27.642 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 05:15:28.346 INFO [stdout] 17daff6bb5e83f3ef928d9ede69a61e66b184efbaa562aa5f042e1b944104000
Dec 05 05:15:28.350 INFO running `"docker" "start" "-a" "17daff6bb5e83f3ef928d9ede69a61e66b184efbaa562aa5f042e1b944104000"`
Dec 05 05:15:29.348 INFO [stderr] usermod: no changes
Dec 05 05:15:29.584 INFO [stderr]    Compiling serde v1.0.38
Dec 05 05:15:29.592 INFO [stderr]    Compiling crc v1.7.0
Dec 05 05:15:29.599 INFO [stderr]    Compiling errno v0.2.3
Dec 05 05:15:29.599 INFO [stderr]    Compiling num-integer v0.1.36
Dec 05 05:15:29.604 INFO [stderr]    Compiling backtrace-sys v0.1.16
Dec 05 05:15:29.604 INFO [stderr]    Compiling serde_derive v1.0.38
Dec 05 05:15:29.604 INFO [stderr]    Compiling sha-1 v0.7.0
Dec 05 05:15:30.631 INFO [stderr]    Compiling backtrace v0.3.6
Dec 05 05:15:31.004 INFO [stderr]    Compiling chrono v0.4.2
Dec 05 05:15:31.836 INFO [stderr]    Compiling libflate v0.1.14
Dec 05 05:15:34.108 INFO [stderr]    Compiling failure v0.1.1
Dec 05 05:15:57.137 INFO [stderr]    Compiling docopt v0.8.3
Dec 05 05:16:03.770 INFO [stderr]    Compiling warcdedupe v0.1.0 (/source)
Dec 05 05:16:04.340 INFO [stderr] warning: unused import: `Result as IoResult`
Dec 05 05:16:04.341 INFO [stderr]  --> src/reader.rs:5:33
Dec 05 05:16:04.341 INFO [stderr]   |
Dec 05 05:16:04.341 INFO [stderr] 5 | use std::io::{Error as IoError, Result as IoResult};
Dec 05 05:16:04.342 INFO [stderr]   |                                 ^^^^^^^^^^^^^^^^^^
Dec 05 05:16:04.342 INFO [stderr]   |
Dec 05 05:16:04.342 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 05 05:16:04.343 INFO [stderr] 
Dec 05 05:16:04.368 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt::is_ascii': use inherent methods instead
Dec 05 05:16:04.368 INFO [stderr]    --> src/lib.rs:338:43
Dec 05 05:16:04.369 INFO [stderr]     |
Dec 05 05:16:04.369 INFO [stderr] 338 |             debug_assert!(m[1].iter().all(std::ascii::AsciiExt::is_ascii));
Dec 05 05:16:04.369 INFO [stderr]     |                                           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:16:04.369 INFO [stderr]     |
Dec 05 05:16:04.369 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 05 05:16:04.369 INFO [stderr] 
Dec 05 05:16:06.628 INFO [stderr] warning: unused variable: `output`
Dec 05 05:16:06.628 INFO [stderr]    --> src/bin/warcdedupe.rs:110:13
Dec 05 05:16:06.628 INFO [stderr]     |
Dec 05 05:16:06.628 INFO [stderr] 110 |     let mut output = open_output_stream(args.arg_outfile, args.flag_compress_output);
Dec 05 05:16:06.628 INFO [stderr]     |             ^^^^^^ help: consider using `_output` instead
Dec 05 05:16:06.628 INFO [stderr]     |
Dec 05 05:16:06.628 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 05 05:16:06.628 INFO [stderr] 
Dec 05 05:16:06.628 INFO [stderr] warning: unused variable: `e`
Dec 05 05:16:06.628 INFO [stderr]    --> src/bin/warcdedupe.rs:141:21
Dec 05 05:16:06.628 INFO [stderr]     |
Dec 05 05:16:06.628 INFO [stderr] 141 |                 Err(e) => unimplemented!(),
Dec 05 05:16:06.628 INFO [stderr]     |                     ^ help: consider using `_e` instead
Dec 05 05:16:06.628 INFO [stderr] 
Dec 05 05:16:06.692 INFO [stderr] warning: variable does not need to be mutable
Dec 05 05:16:06.692 INFO [stderr]    --> src/bin/warcdedupe.rs:110:9
Dec 05 05:16:06.692 INFO [stderr]     |
Dec 05 05:16:06.692 INFO [stderr] 110 |     let mut output = open_output_stream(args.arg_outfile, args.flag_compress_output);
Dec 05 05:16:06.692 INFO [stderr]     |         ----^^^^^^
Dec 05 05:16:06.692 INFO [stderr]     |         |
Dec 05 05:16:06.692 INFO [stderr]     |         help: remove this `mut`
Dec 05 05:16:06.692 INFO [stderr]     |
Dec 05 05:16:06.692 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 05 05:16:06.692 INFO [stderr] 
Dec 05 05:16:10.636 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 41.26s
Dec 05 05:16:10.647 INFO [stderr] su: No module specific data is present
Dec 05 05:16:11.720 INFO running `"docker" "inspect" "17daff6bb5e83f3ef928d9ede69a61e66b184efbaa562aa5f042e1b944104000"`
Dec 05 05:16:12.044 INFO running `"docker" "rm" "-f" "17daff6bb5e83f3ef928d9ede69a61e66b184efbaa562aa5f042e1b944104000"`
Dec 05 05:16:12.380 INFO [stdout] 17daff6bb5e83f3ef928d9ede69a61e66b184efbaa562aa5f042e1b944104000
Dec 05 05:16:12.388 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 05:16:12.986 INFO [stdout] af12704ed7a8656007c0cd05edd7d120a38ca332832c423541ae0ac532f92ff5
Dec 05 05:16:12.990 INFO running `"docker" "start" "-a" "af12704ed7a8656007c0cd05edd7d120a38ca332832c423541ae0ac532f92ff5"`
Dec 05 05:16:14.482 INFO [stderr] usermod: no changes
Dec 05 05:16:14.732 INFO [stderr]    Compiling cast v0.2.2
Dec 05 05:16:14.741 INFO [stderr]    Compiling thread-scoped v1.0.2
Dec 05 05:16:14.744 INFO [stderr]    Compiling term v0.5.1
Dec 05 05:16:14.745 INFO [stderr]    Compiling serde_json v1.0.14
Dec 05 05:16:14.751 INFO [stderr]    Compiling itertools-num v0.1.1
Dec 05 05:16:14.754 INFO [stderr]    Compiling pest_derive v1.0.7
Dec 05 05:16:16.702 INFO [stderr]    Compiling criterion-stats v0.2.3
Dec 05 05:16:16.709 INFO [stderr]    Compiling criterion-plot v0.2.3
Dec 05 05:16:21.249 INFO [stderr]    Compiling simplelog v0.5.1
Dec 05 05:16:28.940 INFO [stderr]    Compiling handlebars v0.31.0
Dec 05 05:16:40.248 INFO [stderr]    Compiling criterion v0.2.3
Dec 05 05:16:49.667 INFO [stderr]    Compiling warcdedupe v0.1.0 (/source)
Dec 05 05:16:50.376 INFO [stderr] warning: unused import: `Result as IoResult`
Dec 05 05:16:50.376 INFO [stderr]  --> src/reader.rs:5:33
Dec 05 05:16:50.376 INFO [stderr]   |
Dec 05 05:16:50.376 INFO [stderr] 5 | use std::io::{Error as IoError, Result as IoResult};
Dec 05 05:16:50.376 INFO [stderr]   |                                 ^^^^^^^^^^^^^^^^^^
Dec 05 05:16:50.376 INFO [stderr]   |
Dec 05 05:16:50.376 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 05 05:16:50.376 INFO [stderr] 
Dec 05 05:16:50.408 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt::is_ascii': use inherent methods instead
Dec 05 05:16:50.408 INFO [stderr]    --> src/lib.rs:338:43
Dec 05 05:16:50.408 INFO [stderr]     |
Dec 05 05:16:50.408 INFO [stderr] 338 |             debug_assert!(m[1].iter().all(std::ascii::AsciiExt::is_ascii));
Dec 05 05:16:50.408 INFO [stderr]     |                                           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:16:50.408 INFO [stderr]     |
Dec 05 05:16:50.408 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 05 05:16:50.408 INFO [stderr] 
Dec 05 05:16:50.836 INFO [stderr] warning: unused variable: `output`
Dec 05 05:16:50.836 INFO [stderr]    --> src/bin/warcdedupe.rs:110:13
Dec 05 05:16:50.836 INFO [stderr]     |
Dec 05 05:16:50.836 INFO [stderr] 110 |     let mut output = open_output_stream(args.arg_outfile, args.flag_compress_output);
Dec 05 05:16:50.836 INFO [stderr]     |             ^^^^^^ help: consider using `_output` instead
Dec 05 05:16:50.836 INFO [stderr]     |
Dec 05 05:16:50.836 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 05 05:16:50.836 INFO [stderr] 
Dec 05 05:16:50.836 INFO [stderr] warning: unused variable: `e`
Dec 05 05:16:50.836 INFO [stderr]    --> src/bin/warcdedupe.rs:141:21
Dec 05 05:16:50.836 INFO [stderr]     |
Dec 05 05:16:50.836 INFO [stderr] 141 |                 Err(e) => unimplemented!(),
Dec 05 05:16:50.836 INFO [stderr]     |                     ^ help: consider using `_e` instead
Dec 05 05:16:50.836 INFO [stderr] 
Dec 05 05:16:50.996 INFO [stderr] warning: variable does not need to be mutable
Dec 05 05:16:50.997 INFO [stderr]    --> src/bin/warcdedupe.rs:110:9
Dec 05 05:16:50.997 INFO [stderr]     |
Dec 05 05:16:51.000 INFO [stderr] 110 |     let mut output = open_output_stream(args.arg_outfile, args.flag_compress_output);
Dec 05 05:16:51.001 INFO [stderr]     |         ----^^^^^^
Dec 05 05:16:51.001 INFO [stderr]     |         |
Dec 05 05:16:51.001 INFO [stderr]     |         help: remove this `mut`
Dec 05 05:16:51.001 INFO [stderr]     |
Dec 05 05:16:51.001 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 05 05:16:51.001 INFO [stderr] 
Dec 05 05:16:53.104 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 38.58s
Dec 05 05:16:53.112 INFO [stderr] su: No module specific data is present
Dec 05 05:16:53.554 INFO running `"docker" "inspect" "af12704ed7a8656007c0cd05edd7d120a38ca332832c423541ae0ac532f92ff5"`
Dec 05 05:16:53.697 INFO running `"docker" "rm" "-f" "af12704ed7a8656007c0cd05edd7d120a38ca332832c423541ae0ac532f92ff5"`
Dec 05 05:16:53.831 INFO [stdout] af12704ed7a8656007c0cd05edd7d120a38ca332832c423541ae0ac532f92ff5
Dec 05 05:16:53.834 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 05:16:53.999 INFO [stdout] 2ad5e0cbc8f8558c850a103eb5c2f51353246762b4a89d2793a30d043e39b992
Dec 05 05:16:54.002 INFO running `"docker" "start" "-a" "2ad5e0cbc8f8558c850a103eb5c2f51353246762b4a89d2793a30d043e39b992"`
Dec 05 05:16:54.436 INFO [stderr] usermod: no changes
Dec 05 05:16:54.468 INFO [stderr]     Blocking waiting for file lock on the registry index
Dec 05 05:16:54.709 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 05 05:16:54.716 INFO [stderr]      Running /target/debug/deps/warcio-4fb0782908ed56fc
Dec 05 05:16:54.719 INFO [stdout] 
Dec 05 05:16:54.719 INFO [stdout] running 5 tests
Dec 05 05:16:54.720 INFO [stdout] test tests::truncated_header_is_invalid ... ok
Dec 05 05:16:54.722 INFO [stdout] test tests::invalid_fields_are_invalid ... ok
Dec 05 05:16:54.723 INFO [stdout] test tests::incorrect_signature_is_invalid ... ok
Dec 05 05:16:54.723 INFO [stdout] test tests::extra_buffering_works ... ok
Dec 05 05:16:54.723 INFO [stdout] test tests::can_read_record_header ... ok
Dec 05 05:16:54.723 INFO [stdout] 
Dec 05 05:16:54.723 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:16:54.723 INFO [stdout] 
Dec 05 05:16:54.724 INFO [stderr]      Running /target/debug/deps/warcdedupe-e258879a85dd6aa6
Dec 05 05:16:54.726 INFO [stdout] 
Dec 05 05:16:54.726 INFO [stdout] running 0 tests
Dec 05 05:16:54.726 INFO [stdout] 
Dec 05 05:16:54.726 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:16:54.726 INFO [stdout] 
Dec 05 05:16:54.727 INFO [stderr]    Doc-tests warcio
Dec 05 05:16:55.323 INFO [stdout] 
Dec 05 05:16:55.323 INFO [stdout] running 0 tests
Dec 05 05:16:55.324 INFO [stdout] 
Dec 05 05:16:55.324 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:16:55.324 INFO [stdout] 
Dec 05 05:16:55.344 INFO [stderr] su: No module specific data is present
Dec 05 05:16:56.144 INFO running `"docker" "inspect" "2ad5e0cbc8f8558c850a103eb5c2f51353246762b4a89d2793a30d043e39b992"`
Dec 05 05:16:56.408 INFO running `"docker" "rm" "-f" "2ad5e0cbc8f8558c850a103eb5c2f51353246762b4a89d2793a30d043e39b992"`
Dec 05 05:16:56.722 INFO [stdout] 2ad5e0cbc8f8558c850a103eb5c2f51353246762b4a89d2793a30d043e39b992