Dec 07 17:38:21.113 INFO testing env_logger-0.6.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 17:38:21.113 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 07 17:38:21.394 INFO [stdout] 3327b9f738adf8017a2b0feda271f5f708b35f1642f00ef46d4e627bbacef49e
Dec 07 17:38:21.395 INFO running `"docker" "start" "-a" "3327b9f738adf8017a2b0feda271f5f708b35f1642f00ef46d4e627bbacef49e"`
Dec 07 17:38:22.163 INFO [stderr] usermod: no changes
Dec 07 17:38:22.308 INFO [stderr]    Compiling env_logger v0.6.0 (/source)
Dec 07 17:38:25.260 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.04s
Dec 07 17:38:25.260 INFO [stderr] su: No module specific data is present
Dec 07 17:38:25.796 INFO running `"docker" "inspect" "3327b9f738adf8017a2b0feda271f5f708b35f1642f00ef46d4e627bbacef49e"`
Dec 07 17:38:26.082 INFO running `"docker" "rm" "-f" "3327b9f738adf8017a2b0feda271f5f708b35f1642f00ef46d4e627bbacef49e"`
Dec 07 17:38:26.467 INFO [stdout] 3327b9f738adf8017a2b0feda271f5f708b35f1642f00ef46d4e627bbacef49e
Dec 07 17:38:26.470 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 07 17:38:27.438 INFO [stdout] 0719624cd5b883d90c33b7a6ca1ce2d4c0fdf73d9124e289d2e43c5512957af8
Dec 07 17:38:27.442 INFO running `"docker" "start" "-a" "0719624cd5b883d90c33b7a6ca1ce2d4c0fdf73d9124e289d2e43c5512957af8"`
Dec 07 17:38:28.881 INFO [stderr] usermod: no changes
Dec 07 17:38:29.012 INFO [stderr]    Compiling env_logger v0.6.0 (/source)
Dec 07 17:38:44.953 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.05s
Dec 07 17:38:44.957 INFO [stderr] su: No module specific data is present
Dec 07 17:38:45.247 INFO running `"docker" "inspect" "0719624cd5b883d90c33b7a6ca1ce2d4c0fdf73d9124e289d2e43c5512957af8"`
Dec 07 17:38:45.372 INFO running `"docker" "rm" "-f" "0719624cd5b883d90c33b7a6ca1ce2d4c0fdf73d9124e289d2e43c5512957af8"`
Dec 07 17:38:45.532 INFO [stdout] 0719624cd5b883d90c33b7a6ca1ce2d4c0fdf73d9124e289d2e43c5512957af8
Dec 07 17:38:45.532 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 07 17:38:45.709 INFO [stdout] 1aadaa39bd3c84f5948d04d8592daf908416e80d44ee8a969cbf60435a128f9d
Dec 07 17:38:45.710 INFO running `"docker" "start" "-a" "1aadaa39bd3c84f5948d04d8592daf908416e80d44ee8a969cbf60435a128f9d"`
Dec 07 17:38:46.230 INFO [stderr] usermod: no changes
Dec 07 17:38:46.304 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 07 17:38:46.304 INFO [stderr]      Running /target/debug/deps/env_logger-57a7e566bb390012
Dec 07 17:38:46.304 INFO [stderr]      Running /target/debug/deps/init_twice_retains_filter-3401b494da5b0362
Dec 07 17:38:46.304 INFO [stderr]      Running /target/debug/deps/log_in_log-bab2365641d39b46
Dec 07 17:38:46.304 INFO [stderr]      Running /target/debug/deps/regexp_filter-2ecabd1fc10965fd
Dec 07 17:38:46.304 INFO [stdout] 
Dec 07 17:38:46.304 INFO [stdout] running 26 tests
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::no_match ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::match_full_path ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::match_default ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::match_beginning_longest_match ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::match_beginning ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::filter_info ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::filter_beginning_longest_match ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_global ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_invalid_crate ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_invalid_level ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_string_level ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_empty_with_filter ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::zero_level ... ok
Dec 07 17:38:46.304 INFO [stdout] test fmt::tests::default_format_no_header ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_valid ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_invalid_crate_filter ... ok
Dec 07 17:38:46.304 INFO [stdout] test fmt::tests::default_format_with_header ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_valid_filter ... ok
Dec 07 17:38:46.304 INFO [stdout] test fmt::writer::tests::parse_write_style_invalid ... ok
Dec 07 17:38:46.304 INFO [stdout] test tests::env_get_write_style_reads_from_var_if_set ... ok
Dec 07 17:38:46.304 INFO [stdout] test fmt::writer::tests::parse_write_style_valid ... ok
Dec 07 17:38:46.304 INFO [stdout] test tests::env_get_filter_reads_from_var_if_set ... ok
Dec 07 17:38:46.304 INFO [stdout] test tests::env_get_write_style_reads_from_default_if_var_not_set ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_default ... ok
Dec 07 17:38:46.304 INFO [stdout] test filter::tests::parse_spec_empty_level ... ok
Dec 07 17:38:46.304 INFO [stdout] test tests::env_get_filter_reads_from_default_if_var_not_set ... ok
Dec 07 17:38:46.304 INFO [stdout] 
Dec 07 17:38:46.304 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 17:38:46.304 INFO [stdout] 
Dec 07 17:38:46.305 INFO [stderr]    Doc-tests env_logger
Dec 07 17:38:48.576 INFO [stdout] 
Dec 07 17:38:48.576 INFO [stdout] running 34 tests
Dec 07 17:39:08.484 INFO [stdout] test src/filter/mod.rs - filter (line 15) ... ok
Dec 07 17:39:13.104 INFO [stdout] test src/filter/mod.rs - filter::Filter::filter (line 134) ... ok
Dec 07 17:39:13.293 INFO [stdout] test src/filter/mod.rs - filter::Builder (line 94) ... ok
Dec 07 17:39:13.403 INFO [stdout] test src/fmt/humantime/extern_impl.rs - fmt::humantime::imp::Formatter::timestamp (line 19) ... ok
Dec 07 17:39:15.160 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Formatter::style (line 24) ... ok
Dec 07 17:39:16.420 INFO [stdout] test src/fmt/mod.rs - fmt (line 15) ... ok
Dec 07 17:39:16.992 INFO [stdout] test src/fmt/mod.rs - fmt::Formatter (line 62) ... ok
Dec 07 17:39:17.844 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style (line 141) ... ok
Dec 07 17:39:24.188 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style (line 160) ... ok
Dec 07 17:39:30.408 INFO [stdout] test src/lib.rs -  (line 17) ... ok
Dec 07 17:39:32.888 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style::set_bold (line 233) ... ok
Dec 07 17:39:33.056 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style::set_intense (line 260) ... ok
Dec 07 17:39:33.108 INFO [stdout] test src/lib.rs -  (line 159) ... ok
Dec 07 17:39:34.108 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style::set_color (line 205) ... ok
Dec 07 17:39:34.496 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style::set_bg (line 284) ... ok
Dec 07 17:39:36.657 INFO [stdout] test src/fmt/writer/termcolor/extern_impl.rs - fmt::writer::termcolor::imp::Style::value (line 311) ... ok
Dec 07 17:39:40.136 INFO [stdout] test src/lib.rs -  (line 181) ... ok
Dec 07 17:39:43.019 INFO [stdout] test src/lib.rs -  (line 201) ... ok
Dec 07 17:39:44.200 INFO [stdout] test src/lib.rs - Builder::filter_level (line 533) ... ok
Dec 07 17:39:44.768 INFO [stdout] test src/lib.rs - Builder (line 308) ... ok
Dec 07 17:39:47.348 INFO [stdout] test src/lib.rs - Builder::format (line 453) ... ok
Dec 07 17:39:48.000 INFO [stdout] test src/lib.rs - Builder::filter_module (line 510) ... ok
Dec 07 17:39:48.864 INFO [stdout] test src/lib.rs - Builder::filter (line 559) ... ok
Dec 07 17:39:50.725 INFO [stdout] test src/lib.rs - Builder::from_default_env (line 427) ... ok
Dec 07 17:39:55.260 INFO [stdout] test src/lib.rs - Builder::from_env (line 381) ... ok
Dec 07 17:39:57.012 INFO [stdout] test src/lib.rs - Builder::new (line 348) ... ok
Dec 07 17:39:57.684 INFO [stdout] test src/lib.rs - Builder::from_env (line 391) ... ok
Dec 07 17:40:02.053 INFO [stdout] test src/lib.rs - Builder::target (line 595) ... ok
Dec 07 17:40:02.100 INFO [stdout] test src/lib.rs - Logger::from_default_env (line 732) ... ok
Dec 07 17:40:02.524 INFO [stdout] test src/lib.rs - Logger::from_env (line 699) ... ok
Dec 07 17:40:02.597 INFO [stdout] test src/lib.rs - Builder::write_style (line 616) ... ok
Dec 07 17:40:03.742 INFO [stdout] test src/lib.rs - Logger::from_env (line 708) ... ok
Dec 07 17:40:05.684 INFO [stdout] test src/lib.rs - init_from_env (line 1052) ... ok
Dec 07 17:40:05.984 INFO [stdout] test src/lib.rs - try_init_from_env (line 1014) ... ok
Dec 07 17:40:05.984 INFO [stdout] 
Dec 07 17:40:05.984 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 17:40:05.984 INFO [stdout] 
Dec 07 17:40:06.012 INFO [stderr] su: No module specific data is present
Dec 07 17:40:06.598 INFO running `"docker" "inspect" "1aadaa39bd3c84f5948d04d8592daf908416e80d44ee8a969cbf60435a128f9d"`
Dec 07 17:40:06.982 INFO running `"docker" "rm" "-f" "1aadaa39bd3c84f5948d04d8592daf908416e80d44ee8a969cbf60435a128f9d"`
Dec 07 17:40:07.264 INFO [stdout] 1aadaa39bd3c84f5948d04d8592daf908416e80d44ee8a969cbf60435a128f9d