Oct 16 11:33:10.693 INFO testing fern-0.5.6 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 16 11:33:10.695 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 16 11:33:11.144 INFO blam! fa77929485235d5cde281d27c7c8b38b6ae88a997c9c6ab6ab066f1075a44eb1
Oct 16 11:33:11.145 INFO running `"docker" "start" "-a" "fa77929485235d5cde281d27c7c8b38b6ae88a997c9c6ab6ab066f1075a44eb1"`
Oct 16 11:33:13.018 INFO kablam! usermod: no changes
Oct 16 11:33:13.183 INFO kablam!    Compiling fern v0.5.6 (/source)
Oct 16 11:33:16.335 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 3.29s
Oct 16 11:33:16.339 INFO kablam! su: No module specific data is present
Oct 16 11:33:17.067 INFO running `"docker" "rm" "-f" "fa77929485235d5cde281d27c7c8b38b6ae88a997c9c6ab6ab066f1075a44eb1"`
Oct 16 11:33:17.323 INFO blam! fa77929485235d5cde281d27c7c8b38b6ae88a997c9c6ab6ab066f1075a44eb1
Oct 16 11:33:17.333 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 16 11:33:17.772 INFO blam! 873ca94f39bf1ef00487bc5c49409691cf4882c12f1bb7df6b6c6f7ba35bfd2f
Oct 16 11:33:17.778 INFO running `"docker" "start" "-a" "873ca94f39bf1ef00487bc5c49409691cf4882c12f1bb7df6b6c6f7ba35bfd2f"`
Oct 16 11:33:19.239 INFO kablam! usermod: no changes
Oct 16 11:33:19.407 INFO kablam!    Compiling fern v0.5.6 (/source)
Oct 16 11:33:31.987 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 12.72s
Oct 16 11:33:31.991 INFO kablam! su: No module specific data is present
Oct 16 11:33:33.801 INFO running `"docker" "rm" "-f" "873ca94f39bf1ef00487bc5c49409691cf4882c12f1bb7df6b6c6f7ba35bfd2f"`
Oct 16 11:33:34.091 INFO blam! 873ca94f39bf1ef00487bc5c49409691cf4882c12f1bb7df6b6c6f7ba35bfd2f
Oct 16 11:33:34.107 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 16 11:33:34.548 INFO blam! f419cecceb89354ca6e3a29792b1857f1fc09800788a68f2381d74edd7437343
Oct 16 11:33:34.551 INFO running `"docker" "start" "-a" "f419cecceb89354ca6e3a29792b1857f1fc09800788a68f2381d74edd7437343"`
Oct 16 11:33:36.864 INFO kablam! usermod: no changes
Oct 16 11:33:36.987 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Oct 16 11:33:36.995 INFO kablam!      Running /target/debug/deps/fern-7e687de5aa1a2489
Oct 16 11:33:37.003 INFO blam! 
Oct 16 11:33:37.003 INFO blam! running 7 tests
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_single_colon_is_not_double_colon ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_simple_hierarchy ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_similar_names_are_not_same ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_hierarchy_correct ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_find_exact_minimal ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_find_exact_many ... ok
Oct 16 11:33:37.003 INFO blam! test log_impl::test::test_level_config_all_chars ... ok
Oct 16 11:33:37.003 INFO blam! 
Oct 16 11:33:37.003 INFO blam! test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.003 INFO blam! 
Oct 16 11:33:37.005 INFO kablam!      Running /target/debug/deps/channel_logging-c5e5121332d4fe9b
Oct 16 11:33:37.019 INFO blam! 
Oct 16 11:33:37.019 INFO blam! running 1 test
Oct 16 11:33:37.019 INFO blam! test test_channel_logging ... ok
Oct 16 11:33:37.019 INFO blam! 
Oct 16 11:33:37.019 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.019 INFO blam! 
Oct 16 11:33:37.020 INFO kablam!      Running /target/debug/deps/file_logging-60b7dfa28c5bb2dc
Oct 16 11:33:37.027 INFO blam! 
Oct 16 11:33:37.027 INFO blam! running 2 tests
Oct 16 11:33:37.027 INFO blam! [INFO] Test information message
Oct 16 11:33:37.027 INFO blam! [WARN] Test warning message
Oct 16 11:33:37.027 INFO blam! [ERROR] Test error message
Oct 16 11:33:37.027 INFO blam! test test_basic_logging_file_logging ... ok
Oct 16 11:33:37.027 INFO blam! test test_custom_line_separators ... ok
Oct 16 11:33:37.027 INFO blam! 
Oct 16 11:33:37.027 INFO blam! test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.027 INFO blam! 
Oct 16 11:33:37.027 INFO kablam!      Running /target/debug/deps/global_logging-07e9dcf0cda5eed9
Oct 16 11:33:37.027 INFO blam! 
Oct 16 11:33:37.027 INFO blam! running 1 test
Oct 16 11:33:37.031 INFO blam! test test_global_logger ... ok
Oct 16 11:33:37.031 INFO blam! 
Oct 16 11:33:37.031 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.031 INFO blam! 
Oct 16 11:33:37.031 INFO blam! 
Oct 16 11:33:37.031 INFO blam! running 0 tests
Oct 16 11:33:37.031 INFO blam! 
Oct 16 11:33:37.031 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.031 INFO blam! 
Oct 16 11:33:37.031 INFO kablam!      Running /target/debug/deps/meta_logging-4e98cdd147879367
Oct 16 11:33:37.031 INFO kablam!      Running /target/debug/deps/panic_logging-e965880f6988913b
Oct 16 11:33:37.035 INFO blam! 
Oct 16 11:33:37.035 INFO blam! running 3 tests
Oct 16 11:33:37.035 INFO blam! this should not panic
Oct 16 11:33:37.043 INFO blam! test double_chained_with_panics_no_info_panic ... ok
Oct 16 11:33:37.095 INFO blam! test test_panic_panics ... ok
Oct 16 11:33:37.095 INFO kablam!      Running /target/debug/deps/support-f71f412c7e61e7cd
Oct 16 11:33:37.095 INFO blam! test double_chained_with_panics_yes_error_panic ... ok
Oct 16 11:33:37.095 INFO blam! 
Oct 16 11:33:37.095 INFO blam! test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.095 INFO blam! 
Oct 16 11:33:37.101 INFO blam! 
Oct 16 11:33:37.101 INFO blam! running 0 tests
Oct 16 11:33:37.101 INFO blam! 
Oct 16 11:33:37.101 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.101 INFO blam! 
Oct 16 11:33:37.102 INFO kablam!      Running /target/debug/deps/write_logging-77e3765737463f30
Oct 16 11:33:37.103 INFO blam! 
Oct 16 11:33:37.103 INFO blam! running 1 test
Oct 16 11:33:37.103 INFO blam! [INFO] Test information message
Oct 16 11:33:37.103 INFO blam! test test_raw_write_logging ... ok
Oct 16 11:33:37.103 INFO blam! 
Oct 16 11:33:37.103 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:33:37.103 INFO blam! 
Oct 16 11:33:37.104 INFO kablam!    Doc-tests fern
Oct 16 11:33:38.283 INFO blam! 
Oct 16 11:33:38.283 INFO blam! running 30 tests
Oct 16 11:33:44.199 INFO blam! test src/builders.rs - builders::Dispatch::format (line 153) ... ok
Oct 16 11:33:45.111 INFO blam! test src/builders.rs - builders::Dispatch::into_shared (line 371) ... ok
Oct 16 11:33:45.411 INFO blam! test src/builders.rs - builders::Dispatch::level (line 212) ... ok
Oct 16 11:33:45.687 INFO blam! test src/builders.rs - builders::Dispatch (line 32) ... ok
Oct 16 11:33:45.935 INFO blam! test src/builders.rs - builders::Dispatch::filter (line 328) ... ok
Oct 16 11:33:46.223 INFO blam! test src/builders.rs - builders::Dispatch::into_log (line 559) ... ok
Oct 16 11:33:46.323 INFO blam! test src/builders.rs - builders::Dispatch::level_for (line 247) ... ok
Oct 16 11:33:48.463 INFO blam! test src/builders.rs - builders::Dispatch::chain (line 187) ... ok
Oct 16 11:33:49.371 INFO blam! test src/builders.rs - builders::Output::file (line 861) ... ok
Oct 16 11:33:49.963 INFO blam! test src/builders.rs - builders::Output::file (line 885) ... ok
Oct 16 11:33:52.107 INFO blam! test src/builders.rs - builders::Dispatch::level_for (line 264) ... ok
Oct 16 11:33:52.187 INFO blam! test src/builders.rs - builders::Output::file (line 872) ... ok
Oct 16 11:33:54.411 INFO blam! test src/builders.rs - builders::Output::call (line 1059) ... ok
Oct 16 11:33:54.862 INFO blam! test src/builders.rs - builders::Output::stderr (line 981) ... ok
Oct 16 11:33:55.083 INFO blam! test src/builders.rs - builders::Output::sender (line 1010) ... ok
Oct 16 11:33:56.479 INFO blam! test src/builders.rs - builders::Output::stderr (line 989) ... ok
Oct 16 11:33:57.519 INFO blam! test src/builders.rs - builders::Output::stdout (line 962) ... ok
Oct 16 11:33:57.803 INFO blam! test src/builders.rs - builders::Output::stdout (line 954) ... ok
Oct 16 11:33:58.183 INFO blam! test src/builders.rs - builders::Output::writer (line 911) ... ok
Oct 16 11:33:58.943 INFO blam! test src/builders.rs - builders::Output::writer (line 928) ... ok
Oct 16 11:33:59.119 INFO blam! test src/builders.rs - builders::Panic (line 687) ... ok
Oct 16 11:34:00.363 INFO blam! test src/builders.rs - builders::Panic (line 665) ... ok
Oct 16 11:34:01.911 INFO blam! test src/lib.rs -  (line 153) ... ok
Oct 16 11:34:02.711 INFO blam! test src/lib.rs - log_file (line 273) ... ok
Oct 16 11:34:04.295 INFO blam! test src/lib.rs -  (line 17) ... ok
Oct 16 11:34:04.875 INFO blam! test src/lib.rs -  (line 32) ... ok
Oct 16 11:34:05.231 INFO blam! test src/log_impl.rs - log_impl::FormatCallback (line 40) ... ok
Oct 16 11:34:05.287 INFO blam! test src/meta.rs - meta (line 50) ... ok
Oct 16 11:34:06.009 INFO blam! test src/meta.rs - meta (line 6) ... ok
Oct 16 11:34:06.042 INFO blam! test src/log_impl.rs - log_impl::FormatCallback<'a>::finish (line 319) ... ok
Oct 16 11:34:06.042 INFO blam! 
Oct 16 11:34:06.042 INFO blam! test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 11:34:06.043 INFO blam! 
Oct 16 11:34:06.054 INFO kablam! su: No module specific data is present
Oct 16 11:34:06.630 INFO running `"docker" "rm" "-f" "f419cecceb89354ca6e3a29792b1857f1fc09800788a68f2381d74edd7437343"`
Oct 16 11:34:06.778 INFO blam! f419cecceb89354ca6e3a29792b1857f1fc09800788a68f2381d74edd7437343