Dec 07 08:11:11.016 INFO testing log-0.4.6 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 08:11:11.017 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 08:11:11.229 INFO [stdout] 2c32fb6afc54b0f1b64bf219a3301ecd24e24c07a8855d098a5a9f996334b6f0
Dec 07 08:11:11.230 INFO running `"docker" "start" "-a" "2c32fb6afc54b0f1b64bf219a3301ecd24e24c07a8855d098a5a9f996334b6f0"`
Dec 07 08:11:11.800 INFO [stderr] usermod: no changes
Dec 07 08:11:11.848 INFO [stderr]    Compiling log v0.4.6 (/source)
Dec 07 08:11:12.179 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.35s
Dec 07 08:11:12.182 INFO [stderr] su: No module specific data is present
Dec 07 08:11:12.530 INFO running `"docker" "inspect" "2c32fb6afc54b0f1b64bf219a3301ecd24e24c07a8855d098a5a9f996334b6f0"`
Dec 07 08:11:12.658 INFO running `"docker" "rm" "-f" "2c32fb6afc54b0f1b64bf219a3301ecd24e24c07a8855d098a5a9f996334b6f0"`
Dec 07 08:11:12.784 INFO [stdout] 2c32fb6afc54b0f1b64bf219a3301ecd24e24c07a8855d098a5a9f996334b6f0
Dec 07 08:11:12.786 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 08:11:13.013 INFO [stdout] 47d0e6b70a52a7be6e84d2696de41032fc44a7d59ac5138c6ed39715b26f5f34
Dec 07 08:11:13.018 INFO running `"docker" "start" "-a" "47d0e6b70a52a7be6e84d2696de41032fc44a7d59ac5138c6ed39715b26f5f34"`
Dec 07 08:11:13.792 INFO [stderr] usermod: no changes
Dec 07 08:11:13.861 INFO [stderr]    Compiling log v0.4.6 (/source)
Dec 07 08:11:15.222 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.41s
Dec 07 08:11:15.224 INFO [stderr] su: No module specific data is present
Dec 07 08:11:15.504 INFO running `"docker" "inspect" "47d0e6b70a52a7be6e84d2696de41032fc44a7d59ac5138c6ed39715b26f5f34"`
Dec 07 08:11:15.557 INFO running `"docker" "rm" "-f" "47d0e6b70a52a7be6e84d2696de41032fc44a7d59ac5138c6ed39715b26f5f34"`
Dec 07 08:11:15.647 INFO [stdout] 47d0e6b70a52a7be6e84d2696de41032fc44a7d59ac5138c6ed39715b26f5f34
Dec 07 08:11:15.649 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 08:11:15.852 INFO [stdout] 8e4560b4006ea8ca1d0e942b43070464ad29191c9f74ba4d08b5df13172f5ac8
Dec 07 08:11:15.853 INFO running `"docker" "start" "-a" "8e4560b4006ea8ca1d0e942b43070464ad29191c9f74ba4d08b5df13172f5ac8"`
Dec 07 08:11:16.595 INFO [stderr] usermod: no changes
Dec 07 08:11:16.668 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 07 08:11:16.668 INFO [stdout] 
Dec 07 08:11:16.668 INFO [stderr]      Running /target/debug/deps/log-6029cba4d07cf3cc
Dec 07 08:11:16.668 INFO [stdout] running 13 tests
Dec 07 08:11:16.688 INFO [stdout] test tests::test_cross_cmp ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_level_from_str ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_cross_eq ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_levelfilter_show ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_metadata_convenience_builder ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_metadata_builder ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_levelfilter_from_str ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_record_complete_builder ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_to_level_filter ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_to_level ... ok
Dec 07 08:11:16.688 INFO [stdout] test tests::test_record_convenience_builder ... ok
Dec 07 08:11:16.696 INFO [stdout] test tests::test_record_builder ... ok
Dec 07 08:11:16.700 INFO [stdout] test tests::test_level_show ... ok
Dec 07 08:11:16.701 INFO [stderr]      Running /target/debug/deps/filters-f3318a061a54580b
Dec 07 08:11:16.701 INFO [stdout] 
Dec 07 08:11:16.701 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:16.701 INFO [stdout] 
Dec 07 08:11:16.716 INFO [stderr]    Doc-tests log
Dec 07 08:11:16.898 INFO [stdout] 
Dec 07 08:11:16.898 INFO [stdout] running 17 tests
Dec 07 08:11:20.028 INFO [stdout] test src/lib.rs -  (line 118) ... ok
Dec 07 08:11:20.496 INFO [stdout] test src/lib.rs - Metadata (line 913) ... ok
Dec 07 08:11:20.672 INFO [stdout] test src/lib.rs -  (line 184) ... ok
Dec 07 08:11:21.297 INFO [stdout] test src/lib.rs - RecordBuilder (line 777) ... ok
Dec 07 08:11:21.300 INFO [stdout] test src/lib.rs - MetadataBuilder (line 970) ... ok
Dec 07 08:11:21.520 INFO [stdout] test src/lib.rs - Record (line 681) ... ok
Dec 07 08:11:21.532 INFO [stdout] test src/lib.rs -  (line 153) ... ok
Dec 07 08:11:23.084 INFO [stdout] test src/lib.rs -  (line 51) ... ok
Dec 07 08:11:23.964 INFO [stdout] test src/lib.rs - RecordBuilder (line 792) ... ok
Dec 07 08:11:24.987 INFO [stdout] test src/macros.rs - log (line 18) ... ok
Dec 07 08:11:24.988 INFO [stdout] test src/lib.rs - set_logger (line 1113) ... ok
Dec 07 08:11:25.458 INFO [stdout] test src/macros.rs - log_enabled (line 181) ... ok
Dec 07 08:11:25.566 INFO [stdout] test src/macros.rs - info (line 99) ... ok
Dec 07 08:11:25.572 INFO [stdout] test src/macros.rs - debug (line 125) ... ok
Dec 07 08:11:26.002 INFO [stdout] test src/macros.rs - trace (line 150) ... ok
Dec 07 08:11:26.002 INFO [stdout] test src/macros.rs - error (line 51) ... ok
Dec 07 08:11:26.053 INFO [stdout] test src/macros.rs - warn (line 75) ... ok
Dec 07 08:11:26.053 INFO [stdout] 
Dec 07 08:11:26.053 INFO [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:26.053 INFO [stdout] 
Dec 07 08:11:26.057 INFO [stderr] su: No module specific data is present
Dec 07 08:11:26.350 INFO running `"docker" "inspect" "8e4560b4006ea8ca1d0e942b43070464ad29191c9f74ba4d08b5df13172f5ac8"`
Dec 07 08:11:26.434 INFO running `"docker" "rm" "-f" "8e4560b4006ea8ca1d0e942b43070464ad29191c9f74ba4d08b5df13172f5ac8"`
Dec 07 08:11:26.532 INFO [stdout] 8e4560b4006ea8ca1d0e942b43070464ad29191c9f74ba4d08b5df13172f5ac8