Nov 17 23:29:23.545 INFO testing serde-protobuf-0.7.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 23:29:23.547 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:29:24.035 INFO [stdout] 0e97bf139bba2dc845afecfdfb13f7d4707cc7476fd90a4d6f958e7f87d7e2fe
Nov 17 23:29:24.036 INFO running `"docker" "start" "-a" "0e97bf139bba2dc845afecfdfb13f7d4707cc7476fd90a4d6f958e7f87d7e2fe"`
Nov 17 23:29:24.847 INFO [stderr] usermod: no changes
Nov 17 23:29:24.933 INFO [stderr]    Compiling serde-protobuf v0.7.0 (/source)
Nov 17 23:29:28.123 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.25s
Nov 17 23:29:28.123 INFO [stderr] su: No module specific data is present
Nov 17 23:29:29.103 INFO running `"docker" "inspect" "0e97bf139bba2dc845afecfdfb13f7d4707cc7476fd90a4d6f958e7f87d7e2fe"`
Nov 17 23:29:29.497 INFO running `"docker" "rm" "-f" "0e97bf139bba2dc845afecfdfb13f7d4707cc7476fd90a4d6f958e7f87d7e2fe"`
Nov 17 23:29:29.791 INFO [stdout] 0e97bf139bba2dc845afecfdfb13f7d4707cc7476fd90a4d6f958e7f87d7e2fe
Nov 17 23:29:29.798 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:29:30.201 INFO [stdout] da424e2393fff13dc8b52cbecd686b48afc817a12caac125889e8937fbd63672
Nov 17 23:29:30.204 INFO running `"docker" "start" "-a" "da424e2393fff13dc8b52cbecd686b48afc817a12caac125889e8937fbd63672"`
Nov 17 23:29:32.124 INFO [stderr] usermod: no changes
Nov 17 23:29:32.211 INFO [stderr]    Compiling serde-value v0.5.3
Nov 17 23:29:34.117 INFO [stderr]    Compiling serde-protobuf v0.7.0 (/source)
Nov 17 23:29:50.772 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.63s
Nov 17 23:29:50.778 INFO [stderr] su: No module specific data is present
Nov 17 23:29:52.263 INFO running `"docker" "inspect" "da424e2393fff13dc8b52cbecd686b48afc817a12caac125889e8937fbd63672"`
Nov 17 23:29:52.575 INFO running `"docker" "rm" "-f" "da424e2393fff13dc8b52cbecd686b48afc817a12caac125889e8937fbd63672"`
Nov 17 23:29:53.031 INFO [stdout] da424e2393fff13dc8b52cbecd686b48afc817a12caac125889e8937fbd63672
Nov 17 23:29:53.034 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:29:53.612 INFO [stdout] 58452bce99c4e8a3b6f735043b0915066656819d70fb5d5ce2b6e7fbe9007319
Nov 17 23:29:53.616 INFO running `"docker" "start" "-a" "58452bce99c4e8a3b6f735043b0915066656819d70fb5d5ce2b6e7fbe9007319"`
Nov 17 23:29:54.885 INFO [stderr] usermod: no changes
Nov 17 23:29:55.007 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Nov 17 23:29:55.015 INFO [stderr]      Running /target/debug/deps/serde_protobuf-81cc35c8fc009500
Nov 17 23:29:55.015 INFO [stdout] 
Nov 17 23:29:55.015 INFO [stdout] running 37 tests
Nov 17 23:29:55.243 INFO [stdout] test descriptor::test::optional_fixed64_field ... ok
Nov 17 23:29:55.253 INFO [stdout] test descriptor::test::optional_double_field ... ok
Nov 17 23:29:55.256 INFO [stdout] test descriptor::test::optional_fixed32_field ... ok
Nov 17 23:29:55.285 INFO [stdout] test descriptor::test::optional_int64_field ... ok
Nov 17 23:29:55.306 INFO [stdout] test descriptor::test::enum_value_foo ... ok
Nov 17 23:29:55.308 INFO [stdout] test descriptor::test::enum_value_baz ... ok
Nov 17 23:29:55.314 INFO [stdout] test descriptor::test::optional_bytes_field ... ok
Nov 17 23:29:55.319 INFO [stdout] test descriptor::test::optional_int32_field ... ok
Nov 17 23:29:55.331 INFO [stdout] test descriptor::test::optional_sfixed32_field ... ok
Nov 17 23:29:55.332 INFO [stdout] test descriptor::test::optional_bool_field ... ok
Nov 17 23:29:55.338 INFO [stdout] test descriptor::test::enum_value_bar ... ok
Nov 17 23:29:55.347 INFO [stdout] test descriptor::test::optional_sfixed64_field ... ok
Nov 17 23:29:55.359 INFO [stdout] test descriptor::test::optional_sint32_field ... ok
Nov 17 23:29:55.359 INFO [stdout] test descriptor::test::optional_sint64_field ... ok
Nov 17 23:29:55.403 INFO [stdout] test descriptor::test::repeated_bool_field ... ok
Nov 17 23:29:55.418 INFO [stdout] test descriptor::test::optional_string_field ... ok
Nov 17 23:29:55.427 INFO [stdout] test descriptor::test::optional_uint32_field ... ok
Nov 17 23:29:55.429 INFO [stdout] test descriptor::test::optional_float_field ... ok
Nov 17 23:29:55.435 INFO [stdout] test descriptor::test::optional_uint64_field ... ok
Nov 17 23:29:55.436 INFO [stdout] test descriptor::test::repeated_double_field ... ok
Nov 17 23:29:55.438 INFO [stdout] test descriptor::test::repeated_bytes_field ... ok
Nov 17 23:29:55.442 INFO [stdout] test descriptor::test::repeated_enum_field ... ok
Nov 17 23:29:55.518 INFO [stdout] test descriptor::test::repeated_fixed32_field ... ok
Nov 17 23:29:55.525 INFO [stdout] test descriptor::test::repeated_sfixed32_field ... ok
Nov 17 23:29:55.528 INFO [stdout] test descriptor::test::repeated_int32_field ... ok
Nov 17 23:29:55.532 INFO [stdout] test descriptor::test::repeated_int64_field ... ok
Nov 17 23:29:55.539 INFO [stdout] test descriptor::test::repeated_sint32_field ... ok
Nov 17 23:29:55.542 INFO [stdout] test descriptor::test::repeated_float_field ... ok
Nov 17 23:29:55.571 INFO [stdout] test descriptor::test::repeated_sfixed64_field ... ok
Nov 17 23:29:55.571 INFO [stdout] test descriptor::test::repeated_fixed64_field ... ok
Nov 17 23:29:55.576 INFO [stdout] test descriptor::test::repeated_string_field ... ok
Nov 17 23:29:55.587 INFO [stdout] test descriptor::test::required_field_b ... ok
Nov 17 23:29:55.594 INFO [stdout] test descriptor::test::repeated_sint64_field ... ok
Nov 17 23:29:55.600 INFO [stdout] test descriptor::test::repeated_uint64_field ... ok
Nov 17 23:29:55.611 INFO [stdout] test descriptor::test::required_field_a ... ok
Nov 17 23:29:55.619 INFO [stdout] test descriptor::test::repeated_uint32_field ... ok
Nov 17 23:29:55.620 INFO [stdout] test descriptor::test::repppeated_message_field ... ok
Nov 17 23:29:55.620 INFO [stdout] 
Nov 17 23:29:55.620 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:29:55.620 INFO [stdout] 
Nov 17 23:29:55.624 INFO [stderr]      Running /target/debug/deps/lib-64984c7e6481d87d
Nov 17 23:29:55.626 INFO [stdout] 
Nov 17 23:29:55.626 INFO [stdout] running 51 tests
Nov 17 23:29:56.083 INFO [stdout] test roundtrip_default_float ... ok
Nov 17 23:29:56.084 INFO [stdout] test roundtrip_default_int64 ... ok
Nov 17 23:29:56.084 INFO [stdout] test roundtrip_default_bool ... ok
Nov 17 23:29:56.103 INFO [stdout] test roundtrip_default_fixed64 ... ok
Nov 17 23:29:56.104 INFO [stdout] test roundtrip_default_int32 ... ok
Nov 17 23:29:56.104 INFO [stdout] test roundtrip_default_double ... ok
Nov 17 23:29:56.104 INFO [stdout] test roundtrip_default_bytes ... ok
Nov 17 23:29:56.104 INFO [stdout] test roundtrip_default_fixed32 ... ok
Nov 17 23:29:56.105 INFO [stdout] test roundtrip_default_sfixed32 ... ok
Nov 17 23:29:56.151 INFO [stdout] test roundtrip_default_uint64 ... ok
Nov 17 23:29:56.184 INFO [stdout] test roundtrip_default_uint32 ... ok
Nov 17 23:29:56.187 INFO [stdout] test roundtrip_default_string ... ok
Nov 17 23:29:56.188 INFO [stdout] test roundtrip_optional_bool ... ok
Nov 17 23:29:56.212 INFO [stdout] test roundtrip_optional_bytes ... ok
Nov 17 23:29:56.227 INFO [stdout] test roundtrip_default_sint32 ... ok
Nov 17 23:29:56.227 INFO [stdout] test roundtrip_default_sint64 ... ok
Nov 17 23:29:56.247 INFO [stdout] test roundtrip_default_sfixed64 ... ok
Nov 17 23:29:56.261 INFO [stdout] test roundtrip_optional_int64 ... ok
Nov 17 23:29:56.275 INFO [stdout] test roundtrip_optional_double ... ok
Nov 17 23:29:56.295 INFO [stdout] test roundtrip_optional_enum ... ok
Nov 17 23:29:56.315 INFO [stdout] test roundtrip_optional_int32 ... ok
Nov 17 23:29:56.339 INFO [stdout] test roundtrip_optional_fixed32 ... ok
Nov 17 23:29:56.347 INFO [stdout] test roundtrip_optional_fixed64 ... ok
Nov 17 23:29:56.347 INFO [stdout] test roundtrip_optional_float ... ok
Nov 17 23:29:56.370 INFO [stdout] test roundtrip_optional_string ... ok
Nov 17 23:29:56.387 INFO [stdout] test roundtrip_optional_sfixed32 ... ok
Nov 17 23:29:56.395 INFO [stdout] test roundtrip_optional_message ... ok
Nov 17 23:29:56.415 INFO [stdout] test roundtrip_optional_sfixed64 ... ok
Nov 17 23:29:56.415 INFO [stdout] test roundtrip_optional_sint32 ... ok
Nov 17 23:29:56.434 INFO [stdout] test roundtrip_optional_sint64 ... ok
Nov 17 23:29:56.443 INFO [stdout] test roundtrip_optional_uint64 ... ok
Nov 17 23:29:56.447 INFO [stdout] test roundtrip_recursive ... ok
Nov 17 23:29:56.463 INFO [stdout] test roundtrip_repeated_bytes ... ok
Nov 17 23:29:56.467 INFO [stdout] test roundtrip_repeated_double ... ok
Nov 17 23:29:56.467 INFO [stdout] test roundtrip_optional_uint32 ... ok
Nov 17 23:29:56.483 INFO [stdout] test roundtrip_repeated_bool ... ok
Nov 17 23:29:56.491 INFO [stdout] test roundtrip_repeated_enum ... ok
Nov 17 23:29:56.499 INFO [stdout] test roundtrip_repeated_fixed32 ... ok
Nov 17 23:29:56.506 INFO [stdout] test roundtrip_repeated_int32 ... ok
Nov 17 23:29:56.535 INFO [stdout] test roundtrip_repeated_int64 ... ok
Nov 17 23:29:56.543 INFO [stdout] test roundtrip_repeated_message ... ok
Nov 17 23:29:56.563 INFO [stdout] test roundtrip_repeated_fixed64 ... ok
Nov 17 23:29:56.571 INFO [stdout] test roundtrip_repeated_sfixed32 ... ok
Nov 17 23:29:56.587 INFO [stdout] test roundtrip_repeated_string ... ok
Nov 17 23:29:56.588 INFO [stdout] test roundtrip_repeated_sfixed64 ... ok
Nov 17 23:29:56.595 INFO [stdout] test roundtrip_repeated_float ... ok
Nov 17 23:29:56.602 INFO [stdout] test roundtrip_repeated_uint32 ... ok
Nov 17 23:29:56.602 INFO [stdout] test roundtrip_repeated_sint32 ... ok
Nov 17 23:29:56.607 INFO [stdout] test roundtrip_repeated_sint64 ... ok
Nov 17 23:29:56.622 INFO [stdout] test roundtrip_repeated_uint64 ... ok
Nov 17 23:29:56.622 INFO [stdout] test roundtrip_required ... ok
Nov 17 23:29:56.622 INFO [stdout] 
Nov 17 23:29:56.622 INFO [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:29:56.622 INFO [stdout] 
Nov 17 23:29:56.635 INFO [stderr]    Doc-tests serde-protobuf
Nov 17 23:29:58.066 INFO [stdout] 
Nov 17 23:29:58.066 INFO [stdout] running 5 tests
Nov 17 23:30:07.047 INFO [stdout] test src/descriptor.rs - descriptor (line 21) ... ok
Nov 17 23:30:08.291 INFO [stdout] test src/descriptor.rs - descriptor (line 80) ... ok
Nov 17 23:30:08.555 INFO [stdout] test src/descriptor.rs - descriptor (line 55) ... ok
Nov 17 23:30:09.359 INFO [stdout] test src/de.rs - de (line 9) ... ok
Nov 17 23:30:09.479 INFO [stdout] test src/descriptor.rs - descriptor (line 102) ... ok
Nov 17 23:30:09.480 INFO [stdout] 
Nov 17 23:30:09.480 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:30:09.480 INFO [stdout] 
Nov 17 23:30:09.499 INFO [stderr] su: No module specific data is present
Nov 17 23:30:10.223 INFO running `"docker" "inspect" "58452bce99c4e8a3b6f735043b0915066656819d70fb5d5ce2b6e7fbe9007319"`
Nov 17 23:30:10.551 INFO running `"docker" "rm" "-f" "58452bce99c4e8a3b6f735043b0915066656819d70fb5d5ce2b6e7fbe9007319"`
Nov 17 23:30:10.827 INFO [stdout] 58452bce99c4e8a3b6f735043b0915066656819d70fb5d5ce2b6e7fbe9007319