Nov 17 17:29:45.474 INFO testing zero-formatter-0.1.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 17:29:45.476 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 17:29:45.915 INFO [stdout] f898ab1d52a95d1f3085e6d61fa18e2be986b40b67184db388fb7e72ec92398c
Nov 17 17:29:45.921 INFO running `"docker" "start" "-a" "f898ab1d52a95d1f3085e6d61fa18e2be986b40b67184db388fb7e72ec92398c"`
Nov 17 17:29:47.351 INFO [stderr] usermod: no changes
Nov 17 17:29:47.443 INFO [stderr]    Compiling num v0.1.42
Nov 17 17:29:47.839 INFO [stderr]    Compiling chrono v0.2.25
Nov 17 17:29:50.634 INFO [stderr]    Compiling zero-formatter v0.1.0 (/source)
Nov 17 17:29:51.666 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.29s
Nov 17 17:29:51.670 INFO [stderr] su: No module specific data is present
Nov 17 17:29:52.011 INFO running `"docker" "inspect" "f898ab1d52a95d1f3085e6d61fa18e2be986b40b67184db388fb7e72ec92398c"`
Nov 17 17:29:52.147 INFO running `"docker" "rm" "-f" "f898ab1d52a95d1f3085e6d61fa18e2be986b40b67184db388fb7e72ec92398c"`
Nov 17 17:29:52.295 INFO [stdout] f898ab1d52a95d1f3085e6d61fa18e2be986b40b67184db388fb7e72ec92398c
Nov 17 17:29:52.303 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 17:29:52.577 INFO [stdout] 049e026660efd00b6e2852d7a46c769d2d505167604e79acf1c8cf8a47e247be
Nov 17 17:29:52.578 INFO running `"docker" "start" "-a" "049e026660efd00b6e2852d7a46c769d2d505167604e79acf1c8cf8a47e247be"`
Nov 17 17:29:53.188 INFO [stderr] usermod: no changes
Nov 17 17:29:53.255 INFO [stderr]    Compiling zero-formatter v0.1.0 (/source)
Nov 17 17:29:56.247 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.03s
Nov 17 17:29:56.262 INFO [stderr] su: No module specific data is present
Nov 17 17:29:56.829 INFO running `"docker" "inspect" "049e026660efd00b6e2852d7a46c769d2d505167604e79acf1c8cf8a47e247be"`
Nov 17 17:29:57.029 INFO running `"docker" "rm" "-f" "049e026660efd00b6e2852d7a46c769d2d505167604e79acf1c8cf8a47e247be"`
Nov 17 17:29:57.244 INFO [stdout] 049e026660efd00b6e2852d7a46c769d2d505167604e79acf1c8cf8a47e247be
Nov 17 17:29:57.247 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 17:29:57.627 INFO [stdout] 480d6904a7e4094c15765ee9dc46e8d250094ea08181cc47e920080835f9739c
Nov 17 17:29:57.633 INFO running `"docker" "start" "-a" "480d6904a7e4094c15765ee9dc46e8d250094ea08181cc47e920080835f9739c"`
Nov 17 17:29:58.675 INFO [stderr] usermod: no changes
Nov 17 17:29:58.755 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 17 17:29:58.763 INFO [stderr]      Running /target/debug/deps/zero_formatter-fa4b6691307303ab
Nov 17 17:29:58.763 INFO [stdout] 
Nov 17 17:29:58.763 INFO [stdout] running 56 tests
Nov 17 17:29:58.764 INFO [stdout] test has_value::tests::serialize_u8_some ... ok
Nov 17 17:29:58.764 INFO [stdout] test has_value::tests::deserialize_u8_some ... ok
Nov 17 17:29:58.764 INFO [stdout] test has_value::tests::deserialize_u8_none ... ok
Nov 17 17:29:58.764 INFO [stdout] test object::tests::deserialize_object_versioning ... ok
Nov 17 17:29:58.764 INFO [stdout] test object::tests::deserialize_struct ... ok
Nov 17 17:29:58.771 INFO [stdout] test object::tests::deserialize_struct_none ... ok
Nov 17 17:29:58.771 INFO [stdout] test object::tests::deserialize_object_none ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::deserialize_object ... ok
Nov 17 17:29:58.779 INFO [stderr]    Doc-tests zero-formatter
Nov 17 17:29:58.779 INFO [stdout] test object::tests::deserialize_object_some ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::deserialize_2_tuple ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_2_tuple ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::deserialize_struct_some ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_object ... ok
Nov 17 17:29:58.779 INFO [stdout] test has_value::tests::serialize_u8_none ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_struct_none ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_struct_some ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_struct ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_f32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_f64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_false ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_object_some ... ok
Nov 17 17:29:58.779 INFO [stdout] test object::tests::serialize_object_none ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_i16 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_i32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_i64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_i8 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_str ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_true ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_u16 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_u32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_u64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::deserialize_u8 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_f32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_f64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_false ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_i16 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_i32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_i64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_i8 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_str ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_true ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_u16 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_u32 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_u64 ... ok
Nov 17 17:29:58.779 INFO [stdout] test primitive::tests::serialize_u8 ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::deserialize_vec ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::deserialize_vec_object ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::deserialize_vec_struct ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::serialize_vec ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::serialize_vec_object ... ok
Nov 17 17:29:58.779 INFO [stdout] test sequence::tests::serialize_vec_struct ... ok
Nov 17 17:29:58.779 INFO [stdout] test time::tests::deserialize_duration ... ok
Nov 17 17:29:58.779 INFO [stdout] test time::tests::serialize_deserialize_datetime_utc ... ok
Nov 17 17:29:58.779 INFO [stdout] test time::tests::serialize_duration ... ok
Nov 17 17:29:58.779 INFO [stdout] test union::tests::serialize_deserialize_union_a ... ok
Nov 17 17:29:58.780 INFO [stdout] test union::tests::serialize_deserialize_union_b ... ok
Nov 17 17:29:58.780 INFO [stdout] 
Nov 17 17:29:58.780 INFO [stdout] test result: ok. 56 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 17:29:58.780 INFO [stdout] 
Nov 17 17:29:59.855 INFO [stdout] 
Nov 17 17:29:59.855 INFO [stdout] running 4 tests
Nov 17 17:30:05.150 INFO [stdout] test src/object.rs - struct_formatter (line 10) ... ok
Nov 17 17:30:05.171 INFO [stdout] test src/lib.rs -  (line 14) ... ok
Nov 17 17:30:05.399 INFO [stdout] test src/object.rs - object_formatter (line 97) ... ok
Nov 17 17:30:05.567 INFO [stdout] test src/union.rs - union_formatter (line 3) ... ok
Nov 17 17:30:05.567 INFO [stdout] 
Nov 17 17:30:05.567 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 17:30:05.567 INFO [stdout] 
Nov 17 17:30:05.603 INFO [stderr] su: No module specific data is present
Nov 17 17:30:06.261 INFO running `"docker" "inspect" "480d6904a7e4094c15765ee9dc46e8d250094ea08181cc47e920080835f9739c"`
Nov 17 17:30:06.558 INFO running `"docker" "rm" "-f" "480d6904a7e4094c15765ee9dc46e8d250094ea08181cc47e920080835f9739c"`
Nov 17 17:30:06.824 INFO [stdout] 480d6904a7e4094c15765ee9dc46e8d250094ea08181cc47e920080835f9739c