Dec 14 01:05:11.876 INFO testing bogdad/timecutrust against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 01:05:11.877 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 01:05:12.192 INFO [stdout] 505aae8e1558e209ba1a86daf9485bb9dba9f8176a85cc4677d6c72f146cc0a3
Dec 14 01:05:12.196 INFO running `"docker" "start" "-a" "505aae8e1558e209ba1a86daf9485bb9dba9f8176a85cc4677d6c72f146cc0a3"`
Dec 14 01:05:13.269 INFO [stderr] usermod: no changes
Dec 14 01:05:13.399 INFO [stderr]    Compiling num-traits v0.1.35
Dec 14 01:05:13.399 INFO [stderr]    Compiling memchr v0.1.11
Dec 14 01:05:13.399 INFO [stderr]    Compiling thread-id v2.0.0
Dec 14 01:05:14.156 INFO [stderr]    Compiling thread_local v0.2.6
Dec 14 01:05:14.879 INFO [stderr]    Compiling aho-corasick v0.5.2
Dec 14 01:05:16.155 INFO [stderr]    Compiling num-integer v0.1.32
Dec 14 01:05:17.471 INFO [stderr]    Compiling regex v0.1.73
Dec 14 01:05:17.667 INFO [stderr]    Compiling num-iter v0.1.32
Dec 14 01:05:18.591 INFO [stderr]    Compiling num v0.1.35
Dec 14 01:05:19.365 INFO [stderr]    Compiling chrono v0.2.25
Dec 14 01:05:29.975 INFO [stderr]    Compiling timecutrust v0.1.0 (/source)
Dec 14 01:05:30.887 INFO [stderr] warning: unused import: `Lines`
Dec 14 01:05:30.887 INFO [stderr]  --> src/main.rs:7:32
Dec 14 01:05:30.887 INFO [stderr]   |
Dec 14 01:05:30.887 INFO [stderr] 7 | use std::io::{self, BufReader, Lines, Write};
Dec 14 01:05:30.887 INFO [stderr]   |                                ^^^^^
Dec 14 01:05:30.887 INFO [stderr]   |
Dec 14 01:05:30.887 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 01:05:30.887 INFO [stderr] 
Dec 14 01:05:30.887 INFO [stderr] warning: unused import: `Error`
Dec 14 01:05:30.887 INFO [stderr]   --> src/main.rs:11:25
Dec 14 01:05:30.887 INFO [stderr]    |
Dec 14 01:05:30.887 INFO [stderr] 11 | use std::io::{SeekFrom, Error, ErrorKind};
Dec 14 01:05:30.887 INFO [stderr]    |                         ^^^^^
Dec 14 01:05:30.887 INFO [stderr] 
Dec 14 01:05:30.887 INFO [stderr] warning: unused import: `Cursor`
Dec 14 01:05:30.887 INFO [stderr]  --> src/textfileutils.rs:1:36
Dec 14 01:05:30.887 INFO [stderr]   |
Dec 14 01:05:30.887 INFO [stderr] 1 | use std::io::{SeekFrom, BufReader, Cursor};
Dec 14 01:05:30.887 INFO [stderr]   |                                    ^^^^^^
Dec 14 01:05:30.887 INFO [stderr] 
Dec 14 01:05:31.021 INFO [stderr] warning: method is never used: `new`
Dec 14 01:05:31.023 INFO [stderr]   --> src/binary_search.rs:40:5
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr] 40 |     fn new(item:i64) -> EqPred {
Dec 14 01:05:31.023 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 14 01:05:31.023 INFO [stderr] 
Dec 14 01:05:31.023 INFO [stderr] warning: function is never used: `matches`
Dec 14 01:05:31.023 INFO [stderr]  --> src/regexps.rs:3:1
Dec 14 01:05:31.023 INFO [stderr]   |
Dec 14 01:05:31.023 INFO [stderr] 3 | pub fn matches(re: &Regex, line: &str) -> bool {
Dec 14 01:05:31.023 INFO [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 01:05:31.023 INFO [stderr] 
Dec 14 01:05:31.023 INFO [stderr] warning: the feature `core` has been stable since 1.6.0 and no longer requires an attribute to enable
Dec 14 01:05:31.023 INFO [stderr]  --> src/main.rs:1:41
Dec 14 01:05:31.023 INFO [stderr]   |
Dec 14 01:05:31.023 INFO [stderr] 1 | #![feature(unboxed_closures, fn_traits, core)]
Dec 14 01:05:31.023 INFO [stderr]   |                                         ^^^^
Dec 14 01:05:31.023 INFO [stderr]   |
Dec 14 01:05:31.023 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 14 01:05:31.023 INFO [stderr] 
Dec 14 01:05:31.023 INFO [stderr] warning: function `monthIndex` should have a snake case name such as `month_index`
Dec 14 01:05:31.023 INFO [stderr]   --> src/datetimes.rs:12:1
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr] 12 | / pub fn monthIndex(line: &str) -> u32 {
Dec 14 01:05:31.023 INFO [stderr] 13 | |     let mut parsed: Parsed = Parsed::new();
Dec 14 01:05:31.023 INFO [stderr] 14 | |     //println!("{}", line);
Dec 14 01:05:31.023 INFO [stderr] 15 | |     let items = vec![Item::Fixed(Fixed::ShortMonthName)];
Dec 14 01:05:31.023 INFO [stderr] ...  |
Dec 14 01:05:31.023 INFO [stderr] 18 | |     parsed.month.unwrap()
Dec 14 01:05:31.023 INFO [stderr] 19 | | }
Dec 14 01:05:31.023 INFO [stderr]    | |_^
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr]    = note: #[warn(non_snake_case)] on by default
Dec 14 01:05:31.023 INFO [stderr] 
Dec 14 01:05:31.023 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 14 01:05:31.023 INFO [stderr]   --> src/datetimes.rs:17:5
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr] 17 |     format::parse(& mut parsed, line, items_iter);
Dec 14 01:05:31.023 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 01:05:31.023 INFO [stderr]    |
Dec 14 01:05:31.023 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 14 01:05:31.023 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 14 01:05:31.023 INFO [stderr] 
Dec 14 01:05:32.815 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.51s
Dec 14 01:05:32.819 INFO [stderr] su: No module specific data is present
Dec 14 01:05:33.727 INFO running `"docker" "inspect" "505aae8e1558e209ba1a86daf9485bb9dba9f8176a85cc4677d6c72f146cc0a3"`
Dec 14 01:05:34.096 INFO running `"docker" "rm" "-f" "505aae8e1558e209ba1a86daf9485bb9dba9f8176a85cc4677d6c72f146cc0a3"`
Dec 14 01:05:34.368 INFO [stdout] 505aae8e1558e209ba1a86daf9485bb9dba9f8176a85cc4677d6c72f146cc0a3
Dec 14 01:05:34.375 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 01:05:34.907 INFO [stdout] c1293c80c19fe91618c0ce979f174efb337cbe2568328880ae1e7e3364221c6d
Dec 14 01:05:34.911 INFO running `"docker" "start" "-a" "c1293c80c19fe91618c0ce979f174efb337cbe2568328880ae1e7e3364221c6d"`
Dec 14 01:05:36.186 INFO [stderr] usermod: no changes
Dec 14 01:05:36.327 INFO [stderr]    Compiling timecutrust v0.1.0 (/source)
Dec 14 01:05:37.411 INFO [stderr] warning: unused import: `Lines`
Dec 14 01:05:37.411 INFO [stderr]  --> src/main.rs:7:32
Dec 14 01:05:37.411 INFO [stderr]   |
Dec 14 01:05:37.411 INFO [stderr] 7 | use std::io::{self, BufReader, Lines, Write};
Dec 14 01:05:37.411 INFO [stderr]   |                                ^^^^^
Dec 14 01:05:37.411 INFO [stderr]   |
Dec 14 01:05:37.411 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 01:05:37.411 INFO [stderr] 
Dec 14 01:05:37.411 INFO [stderr] warning: unused import: `Error`
Dec 14 01:05:37.411 INFO [stderr]   --> src/main.rs:11:25
Dec 14 01:05:37.411 INFO [stderr]    |
Dec 14 01:05:37.411 INFO [stderr] 11 | use std::io::{SeekFrom, Error, ErrorKind};
Dec 14 01:05:37.411 INFO [stderr]    |                         ^^^^^
Dec 14 01:05:37.411 INFO [stderr] 
Dec 14 01:05:37.697 INFO [stderr] warning: the feature `core` has been stable since 1.6.0 and no longer requires an attribute to enable
Dec 14 01:05:37.697 INFO [stderr]  --> src/main.rs:1:41
Dec 14 01:05:37.697 INFO [stderr]   |
Dec 14 01:05:37.697 INFO [stderr] 1 | #![feature(unboxed_closures, fn_traits, core)]
Dec 14 01:05:37.698 INFO [stderr]   |                                         ^^^^
Dec 14 01:05:37.698 INFO [stderr]   |
Dec 14 01:05:37.698 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 14 01:05:37.698 INFO [stderr] 
Dec 14 01:05:37.698 INFO [stderr] warning: function `monthIndex` should have a snake case name such as `month_index`
Dec 14 01:05:37.698 INFO [stderr]   --> src/datetimes.rs:12:1
Dec 14 01:05:37.698 INFO [stderr]    |
Dec 14 01:05:37.698 INFO [stderr] 12 | / pub fn monthIndex(line: &str) -> u32 {
Dec 14 01:05:37.698 INFO [stderr] 13 | |     let mut parsed: Parsed = Parsed::new();
Dec 14 01:05:37.698 INFO [stderr] 14 | |     //println!("{}", line);
Dec 14 01:05:37.698 INFO [stderr] 15 | |     let items = vec![Item::Fixed(Fixed::ShortMonthName)];
Dec 14 01:05:37.698 INFO [stderr] ...  |
Dec 14 01:05:37.698 INFO [stderr] 18 | |     parsed.month.unwrap()
Dec 14 01:05:37.698 INFO [stderr] 19 | | }
Dec 14 01:05:37.698 INFO [stderr]    | |_^
Dec 14 01:05:37.698 INFO [stderr]    |
Dec 14 01:05:37.698 INFO [stderr]    = note: #[warn(non_snake_case)] on by default
Dec 14 01:05:37.698 INFO [stderr] 
Dec 14 01:05:37.698 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 14 01:05:37.698 INFO [stderr]   --> src/datetimes.rs:17:5
Dec 14 01:05:37.698 INFO [stderr]    |
Dec 14 01:05:37.698 INFO [stderr] 17 |     format::parse(& mut parsed, line, items_iter);
Dec 14 01:05:37.698 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 01:05:37.698 INFO [stderr]    |
Dec 14 01:05:37.698 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 14 01:05:37.698 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 14 01:05:37.698 INFO [stderr] 
Dec 14 01:05:38.939 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.71s
Dec 14 01:05:38.939 INFO [stderr] su: No module specific data is present
Dec 14 01:05:39.538 INFO running `"docker" "inspect" "c1293c80c19fe91618c0ce979f174efb337cbe2568328880ae1e7e3364221c6d"`
Dec 14 01:05:39.789 INFO running `"docker" "rm" "-f" "c1293c80c19fe91618c0ce979f174efb337cbe2568328880ae1e7e3364221c6d"`
Dec 14 01:05:40.067 INFO [stdout] c1293c80c19fe91618c0ce979f174efb337cbe2568328880ae1e7e3364221c6d
Dec 14 01:05:40.069 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 01:05:40.713 INFO [stdout] 5e3f66f7828ba7ff1727977fb328b6aaafd1195374847114714b5cbb3a3928e5
Dec 14 01:05:40.715 INFO running `"docker" "start" "-a" "5e3f66f7828ba7ff1727977fb328b6aaafd1195374847114714b5cbb3a3928e5"`
Dec 14 01:05:41.835 INFO [stderr] usermod: no changes
Dec 14 01:05:41.941 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 14 01:05:41.947 INFO [stderr]      Running /target/debug/deps/timecutrust-9acec15c4528537b
Dec 14 01:05:41.988 INFO [stdout] 
Dec 14 01:05:41.988 INFO [stdout] running 5 tests
Dec 14 01:05:41.999 INFO [stdout] test binary_search::test_binary_search ... ok
Dec 14 01:05:41.999 INFO [stdout] test textfileutils::find_new_line_pos_works ... ok
Dec 14 01:05:42.010 INFO [stdout] test datetimes::test_sample_regexp ... ok
Dec 14 01:05:42.021 INFO [stdout] test regexps::test_sample_regexp ... ok
Dec 14 01:05:42.028 INFO [stdout] test datetimes::test_nginx_regexp ... ok
Dec 14 01:05:42.028 INFO [stdout] 
Dec 14 01:05:42.028 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:05:42.028 INFO [stdout] 
Dec 14 01:05:42.039 INFO [stderr] su: No module specific data is present
Dec 14 01:05:42.727 INFO running `"docker" "inspect" "5e3f66f7828ba7ff1727977fb328b6aaafd1195374847114714b5cbb3a3928e5"`
Dec 14 01:05:43.081 INFO running `"docker" "rm" "-f" "5e3f66f7828ba7ff1727977fb328b6aaafd1195374847114714b5cbb3a3928e5"`
Dec 14 01:05:43.413 INFO [stdout] 5e3f66f7828ba7ff1727977fb328b6aaafd1195374847114714b5cbb3a3928e5