Dec 06 23:29:02.247 INFO testing serde-protobuf-0.7.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 23:29:02.247 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 23:29:02.512 INFO [stdout] 8e06b181d11c648ef1f9ce6d2d343a75edde90511065ae3c1eb6f733c0e55f9a
Dec 06 23:29:02.514 INFO running `"docker" "start" "-a" "8e06b181d11c648ef1f9ce6d2d343a75edde90511065ae3c1eb6f733c0e55f9a"`
Dec 06 23:29:03.128 INFO [stderr] usermod: no changes
Dec 06 23:29:03.202 INFO [stderr]    Compiling serde-protobuf v0.7.0 (/source)
Dec 06 23:29:05.797 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.64s
Dec 06 23:29:05.798 INFO [stderr] su: No module specific data is present
Dec 06 23:29:06.150 INFO running `"docker" "inspect" "8e06b181d11c648ef1f9ce6d2d343a75edde90511065ae3c1eb6f733c0e55f9a"`
Dec 06 23:29:06.275 INFO running `"docker" "rm" "-f" "8e06b181d11c648ef1f9ce6d2d343a75edde90511065ae3c1eb6f733c0e55f9a"`
Dec 06 23:29:06.488 INFO [stdout] 8e06b181d11c648ef1f9ce6d2d343a75edde90511065ae3c1eb6f733c0e55f9a
Dec 06 23:29:06.494 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 23:29:06.674 INFO [stdout] 379d74ecfa29c9e6d10bf953239770091e48397a9522fb79d1812d60ee1474e8
Dec 06 23:29:06.681 INFO running `"docker" "start" "-a" "379d74ecfa29c9e6d10bf953239770091e48397a9522fb79d1812d60ee1474e8"`
Dec 06 23:29:07.442 INFO [stderr] usermod: no changes
Dec 06 23:29:07.497 INFO [stderr]    Compiling serde-value v0.5.3
Dec 06 23:29:08.877 INFO [stderr]    Compiling serde-protobuf v0.7.0 (/source)
Dec 06 23:29:24.176 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.70s
Dec 06 23:29:24.184 INFO [stderr] su: No module specific data is present
Dec 06 23:29:25.016 INFO running `"docker" "inspect" "379d74ecfa29c9e6d10bf953239770091e48397a9522fb79d1812d60ee1474e8"`
Dec 06 23:29:25.298 INFO running `"docker" "rm" "-f" "379d74ecfa29c9e6d10bf953239770091e48397a9522fb79d1812d60ee1474e8"`
Dec 06 23:29:25.575 INFO [stdout] 379d74ecfa29c9e6d10bf953239770091e48397a9522fb79d1812d60ee1474e8
Dec 06 23:29:25.577 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 23:29:26.000 INFO [stdout] aa0041748446ad5d703bd676bcff1a1d336bd7cd1a8c0708ed7234384a157e5d
Dec 06 23:29:26.008 INFO running `"docker" "start" "-a" "aa0041748446ad5d703bd676bcff1a1d336bd7cd1a8c0708ed7234384a157e5d"`
Dec 06 23:29:29.337 INFO [stderr] usermod: no changes
Dec 06 23:29:29.415 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 06 23:29:29.417 INFO [stderr]      Running /target/debug/deps/serde_protobuf-90f8cec724857cea
Dec 06 23:29:29.428 INFO [stdout] 
Dec 06 23:29:29.428 INFO [stdout] running 37 tests
Dec 06 23:29:29.586 INFO [stdout] test descriptor::test::optional_double_field ... ok
Dec 06 23:29:29.594 INFO [stdout] test descriptor::test::enum_value_baz ... ok
Dec 06 23:29:29.605 INFO [stdout] test descriptor::test::optional_bool_field ... ok
Dec 06 23:29:29.610 INFO [stdout] test descriptor::test::optional_bytes_field ... ok
Dec 06 23:29:29.611 INFO [stdout] test descriptor::test::enum_value_foo ... ok
Dec 06 23:29:29.621 INFO [stdout] test descriptor::test::enum_value_bar ... ok
Dec 06 23:29:29.629 INFO [stdout] test descriptor::test::optional_fixed64_field ... ok
Dec 06 23:29:29.636 INFO [stdout] test descriptor::test::optional_sfixed32_field ... ok
Dec 06 23:29:29.639 INFO [stdout] test descriptor::test::optional_int32_field ... ok
Dec 06 23:29:29.643 INFO [stdout] test descriptor::test::optional_float_field ... ok
Dec 06 23:29:29.653 INFO [stdout] test descriptor::test::optional_sfixed64_field ... ok
Dec 06 23:29:29.658 INFO [stdout] test descriptor::test::optional_fixed32_field ... ok
Dec 06 23:29:29.658 INFO [stdout] test descriptor::test::optional_sint64_field ... ok
Dec 06 23:29:29.658 INFO [stdout] test descriptor::test::optional_int64_field ... ok
Dec 06 23:29:29.658 INFO [stdout] test descriptor::test::optional_sint32_field ... ok
Dec 06 23:29:29.662 INFO [stdout] test descriptor::test::optional_uint32_field ... ok
Dec 06 23:29:29.662 INFO [stdout] test descriptor::test::optional_string_field ... ok
Dec 06 23:29:29.667 INFO [stdout] test descriptor::test::repeated_fixed32_field ... ok
Dec 06 23:29:29.684 INFO [stdout] test descriptor::test::repeated_enum_field ... ok
Dec 06 23:29:29.688 INFO [stdout] test descriptor::test::repeated_int32_field ... ok
Dec 06 23:29:29.696 INFO [stdout] test descriptor::test::repeated_double_field ... ok
Dec 06 23:29:29.708 INFO [stdout] test descriptor::test::repeated_fixed64_field ... ok
Dec 06 23:29:29.708 INFO [stdout] test descriptor::test::repeated_float_field ... ok
Dec 06 23:29:29.715 INFO [stdout] test descriptor::test::repeated_bool_field ... ok
Dec 06 23:29:29.720 INFO [stdout] test descriptor::test::repeated_sfixed64_field ... ok
Dec 06 23:29:29.722 INFO [stdout] test descriptor::test::optional_uint64_field ... ok
Dec 06 23:29:29.740 INFO [stdout] test descriptor::test::repeated_uint64_field ... ok
Dec 06 23:29:29.744 INFO [stdout] test descriptor::test::repeated_sfixed32_field ... ok
Dec 06 23:29:29.747 INFO [stdout] test descriptor::test::repeated_bytes_field ... ok
Dec 06 23:29:29.747 INFO [stdout] test descriptor::test::repeated_int64_field ... ok
Dec 06 23:29:29.753 INFO [stdout] test descriptor::test::repeated_sint64_field ... ok
Dec 06 23:29:29.769 INFO [stdout] test descriptor::test::repeated_uint32_field ... ok
Dec 06 23:29:29.774 INFO [stdout] test descriptor::test::repppeated_message_field ... ok
Dec 06 23:29:29.774 INFO [stdout] test descriptor::test::repeated_sint32_field ... ok
Dec 06 23:29:29.782 INFO [stdout] test descriptor::test::repeated_string_field ... ok
Dec 06 23:29:29.782 INFO [stdout] test descriptor::test::required_field_a ... ok
Dec 06 23:29:29.785 INFO [stdout] test descriptor::test::required_field_b ... ok
Dec 06 23:29:29.785 INFO [stdout] 
Dec 06 23:29:29.785 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:29:29.786 INFO [stdout] 
Dec 06 23:29:29.786 INFO [stderr]      Running /target/debug/deps/lib-d5843d4ebe995068
Dec 06 23:29:29.798 INFO [stdout] 
Dec 06 23:29:29.798 INFO [stdout] running 51 tests
Dec 06 23:29:30.047 INFO [stdout] test roundtrip_default_float ... ok
Dec 06 23:29:30.048 INFO [stdout] test roundtrip_default_bool ... ok
Dec 06 23:29:30.048 INFO [stdout] test roundtrip_default_int32 ... ok
Dec 06 23:29:30.048 INFO [stdout] test roundtrip_default_double ... ok
Dec 06 23:29:30.050 INFO [stdout] test roundtrip_default_fixed32 ... ok
Dec 06 23:29:30.055 INFO [stdout] test roundtrip_default_int64 ... ok
Dec 06 23:29:30.058 INFO [stdout] test roundtrip_default_bytes ... ok
Dec 06 23:29:30.061 INFO [stdout] test roundtrip_default_fixed64 ... ok
Dec 06 23:29:30.062 INFO [stdout] test roundtrip_default_sint32 ... ok
Dec 06 23:29:30.068 INFO [stdout] test roundtrip_default_sfixed64 ... ok
Dec 06 23:29:30.079 INFO [stdout] test roundtrip_default_uint32 ... ok
Dec 06 23:29:30.084 INFO [stdout] test roundtrip_default_sint64 ... ok
Dec 06 23:29:30.085 INFO [stdout] test roundtrip_optional_bytes ... ok
Dec 06 23:29:30.093 INFO [stdout] test roundtrip_default_uint64 ... ok
Dec 06 23:29:30.095 INFO [stdout] test roundtrip_default_string ... ok
Dec 06 23:29:30.100 INFO [stdout] test roundtrip_optional_enum ... ok
Dec 06 23:29:30.105 INFO [stdout] test roundtrip_optional_fixed64 ... ok
Dec 06 23:29:30.120 INFO [stdout] test roundtrip_optional_bool ... ok
Dec 06 23:29:30.120 INFO [stdout] test roundtrip_optional_double ... ok
Dec 06 23:29:30.132 INFO [stdout] test roundtrip_default_sfixed32 ... ok
Dec 06 23:29:30.132 INFO [stdout] test roundtrip_optional_fixed32 ... ok
Dec 06 23:29:30.132 INFO [stdout] test roundtrip_optional_sfixed32 ... ok
Dec 06 23:29:30.132 INFO [stdout] test roundtrip_optional_float ... ok
Dec 06 23:29:30.136 INFO [stdout] test roundtrip_optional_sfixed64 ... ok
Dec 06 23:29:30.140 INFO [stdout] test roundtrip_optional_int32 ... ok
Dec 06 23:29:30.140 INFO [stdout] test roundtrip_optional_message ... ok
Dec 06 23:29:30.160 INFO [stdout] test roundtrip_optional_int64 ... ok
Dec 06 23:29:30.160 INFO [stdout] test roundtrip_optional_uint32 ... ok
Dec 06 23:29:30.167 INFO [stdout] test roundtrip_optional_string ... ok
Dec 06 23:29:30.168 INFO [stdout] test roundtrip_optional_sint32 ... ok
Dec 06 23:29:30.170 INFO [stdout] test roundtrip_recursive ... ok
Dec 06 23:29:30.183 INFO [stdout] test roundtrip_repeated_bool ... ok
Dec 06 23:29:30.188 INFO [stdout] test roundtrip_repeated_double ... ok
Dec 06 23:29:30.189 INFO [stdout] test roundtrip_optional_sint64 ... ok
Dec 06 23:29:30.194 INFO [stdout] test roundtrip_repeated_bytes ... ok
Dec 06 23:29:30.200 INFO [stdout] test roundtrip_repeated_enum ... ok
Dec 06 23:29:30.210 INFO [stdout] test roundtrip_repeated_int32 ... ok
Dec 06 23:29:30.212 INFO [stdout] test roundtrip_repeated_fixed32 ... ok
Dec 06 23:29:30.218 INFO [stdout] test roundtrip_repeated_fixed64 ... ok
Dec 06 23:29:30.218 INFO [stdout] test roundtrip_repeated_int64 ... ok
Dec 06 23:29:30.227 INFO [stdout] test roundtrip_repeated_sfixed64 ... ok
Dec 06 23:29:30.227 INFO [stdout] test roundtrip_optional_uint64 ... ok
Dec 06 23:29:30.235 INFO [stdout] test roundtrip_repeated_message ... ok
Dec 06 23:29:30.243 INFO [stdout] test roundtrip_repeated_float ... ok
Dec 06 23:29:30.244 INFO [stdout] test roundtrip_repeated_uint32 ... ok
Dec 06 23:29:30.251 INFO [stdout] test roundtrip_repeated_sint64 ... ok
Dec 06 23:29:30.265 INFO [stdout] test roundtrip_repeated_sfixed32 ... ok
Dec 06 23:29:30.270 INFO [stdout] test roundtrip_repeated_string ... ok
Dec 06 23:29:30.280 INFO [stdout] test roundtrip_required ... ok
Dec 06 23:29:30.280 INFO [stdout] test roundtrip_repeated_sint32 ... ok
Dec 06 23:29:30.280 INFO [stdout] test roundtrip_repeated_uint64 ... ok
Dec 06 23:29:30.280 INFO [stdout] 
Dec 06 23:29:30.280 INFO [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:29:30.280 INFO [stdout] 
Dec 06 23:29:30.289 INFO [stderr]    Doc-tests serde-protobuf
Dec 06 23:29:31.715 INFO [stdout] 
Dec 06 23:29:31.715 INFO [stdout] running 5 tests
Dec 06 23:29:36.821 INFO [stdout] test src/descriptor.rs - descriptor (line 21) ... ok
Dec 06 23:29:36.936 INFO [stdout] test src/descriptor.rs - descriptor (line 55) ... ok
Dec 06 23:29:37.004 INFO [stdout] test src/descriptor.rs - descriptor (line 102) ... ok
Dec 06 23:29:37.238 INFO [stdout] test src/descriptor.rs - descriptor (line 80) ... ok
Dec 06 23:29:37.948 INFO [stdout] test src/de.rs - de (line 9) ... ok
Dec 06 23:29:37.948 INFO [stdout] 
Dec 06 23:29:37.948 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:29:37.948 INFO [stdout] 
Dec 06 23:29:37.972 INFO [stderr] su: No module specific data is present
Dec 06 23:29:38.524 INFO running `"docker" "inspect" "aa0041748446ad5d703bd676bcff1a1d336bd7cd1a8c0708ed7234384a157e5d"`
Dec 06 23:29:38.716 INFO running `"docker" "rm" "-f" "aa0041748446ad5d703bd676bcff1a1d336bd7cd1a8c0708ed7234384a157e5d"`
Dec 06 23:29:38.960 INFO [stdout] aa0041748446ad5d703bd676bcff1a1d336bd7cd1a8c0708ed7234384a157e5d