Dec 14 21:32:52.800 INFO testing rustc-ap-serialize-308.0.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 21:32:52.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 21:32:53.208 INFO [stdout] 4c65618ad7d9db35b2d3f27ee4ac1b77f027d4edc8840465d214a1fffa089189
Dec 14 21:32:53.211 INFO running `"docker" "start" "-a" "4c65618ad7d9db35b2d3f27ee4ac1b77f027d4edc8840465d214a1fffa089189"`
Dec 14 21:32:54.339 INFO [stderr] usermod: no changes
Dec 14 21:32:54.375 INFO [stderr]    Compiling rustc-ap-serialize v308.0.0 (/source)
Dec 14 21:32:59.200 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.84s
Dec 14 21:32:59.202 INFO [stderr] su: No module specific data is present
Dec 14 21:33:00.212 INFO running `"docker" "inspect" "4c65618ad7d9db35b2d3f27ee4ac1b77f027d4edc8840465d214a1fffa089189"`
Dec 14 21:33:00.401 INFO running `"docker" "rm" "-f" "4c65618ad7d9db35b2d3f27ee4ac1b77f027d4edc8840465d214a1fffa089189"`
Dec 14 21:33:00.543 INFO [stdout] 4c65618ad7d9db35b2d3f27ee4ac1b77f027d4edc8840465d214a1fffa089189
Dec 14 21:33:00.545 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 21:33:00.780 INFO [stdout] 7468e7feb2427adfc83ff78098a4e6070777c88595dfe59ca93220165c723f9e
Dec 14 21:33:00.783 INFO running `"docker" "start" "-a" "7468e7feb2427adfc83ff78098a4e6070777c88595dfe59ca93220165c723f9e"`
Dec 14 21:33:01.320 INFO [stderr] usermod: no changes
Dec 14 21:33:01.362 INFO [stderr]    Compiling rustc-ap-serialize v308.0.0 (/source)
Dec 14 21:33:13.475 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.12s
Dec 14 21:33:13.478 INFO [stderr] su: No module specific data is present
Dec 14 21:33:14.778 INFO running `"docker" "inspect" "7468e7feb2427adfc83ff78098a4e6070777c88595dfe59ca93220165c723f9e"`
Dec 14 21:33:15.100 INFO running `"docker" "rm" "-f" "7468e7feb2427adfc83ff78098a4e6070777c88595dfe59ca93220165c723f9e"`
Dec 14 21:33:15.395 INFO [stdout] 7468e7feb2427adfc83ff78098a4e6070777c88595dfe59ca93220165c723f9e
Dec 14 21:33:15.400 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 21:33:15.980 INFO [stdout] 84347e558421abd9d1989077b2f80edad71ab39e30700a26b32fc9266705168d
Dec 14 21:33:15.983 INFO running `"docker" "start" "-a" "84347e558421abd9d1989077b2f80edad71ab39e30700a26b32fc9266705168d"`
Dec 14 21:33:18.067 INFO [stderr] usermod: no changes
Dec 14 21:33:18.123 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 14 21:33:18.123 INFO [stderr]      Running /target/debug/deps/serialize-5d4bac3597757503
Dec 14 21:33:18.127 INFO [stdout] 
Dec 14 21:33:18.127 INFO [stdout] running 112 tests
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::bench_to_hex ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::bench_from_hex ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_from_hex_okay ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_from_hex_invalid_char ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_from_hex_ignores_whitespace ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_from_hex_all_bytes ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_from_hex_odd_len ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_to_hex_all_bytes ... ok
Dec 14 21:33:18.139 INFO [stdout] test hex::tests::test_to_hex ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::bench_streaming_small ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::bench_small ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::bench_large ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::bench_streaming_large ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_object ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_string ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_u64 ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_f64 ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_boolean ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_as_array ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_array ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_enum ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_errors_enum ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_option_malformed ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_errors_struct ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_option ... ok
Dec 14 21:33:18.139 INFO [stdout] test json::tests::test_decode_identifiers ... ok
Dec 14 21:33:18.147 INFO [stdout] test json::tests::test_decode_option_some ... ok
Dec 14 21:33:18.147 INFO [stdout] test json::tests::test_decode_numbers ... ok
Dec 14 21:33:18.155 INFO [stdout] test json::tests::test_decode_option_none ... ok
Dec 14 21:33:18.155 INFO [stdout] test json::tests::test_as_i64 ... ok
Dec 14 21:33:18.155 INFO [stdout] test json::tests::test_as_null ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_struct ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_tuple ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_map ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_tuple_malformed_types ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_tuple_malformed_length ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_struct_with_nan ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_decode_str ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_encode_hashmap_with_numeric_key ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_encode_hashmap_with_arbitrary_key ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_array ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_boolean ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_f64 ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_i64 ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_null ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_number ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_object ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_string ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_is_u64 ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_multiline_errors ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_prettyencode_hashmap_with_numeric_key ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_prettyencoder_indent_level_param ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_array ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_array_streaming ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_identifiers ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_identifiers_streaming ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_number ... ok
Dec 14 21:33:18.167 INFO [stdout] test json::tests::test_read_object ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_read_object_streaming ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_index ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_find ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_find_path ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_from_str_trait ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_hashmap_with_enum_key ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_hashmap_with_numeric_key_will_error_with_string_keys ... ok
Dec 14 21:33:18.175 INFO [stdout] test json::tests::test_hashmap_with_numeric_key_can_handle_double_quote_delimited_key ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_search ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_read_str ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_stack ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_trailing_characters_streaming ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_trailing_characters ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_to_json ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_streaming_parser ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_array ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_char ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_bool ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_null ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_object ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_none ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_str ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_some ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_signed_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_u16_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_u128_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_u32_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_u64_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test opaque::tests::test_bool ... ok
Dec 14 21:33:18.187 INFO [stdout] test leb128::test_usize_leb128 ... ok
Dec 14 21:33:18.187 INFO [stdout] test opaque::tests::test_char ... ok
Dec 14 21:33:18.187 INFO [stdout] test opaque::tests::test_enum ... ok
Dec 14 21:33:18.187 INFO [stdout] test opaque::tests::test_f32 ... ok
Dec 14 21:33:18.187 INFO [stdout] test opaque::tests::test_f64 ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_enum ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_f64 ... ok
Dec 14 21:33:18.187 INFO [stdout] test json::tests::test_write_i64 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_hash_map ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_i32 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_i64 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_sequence ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_option ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_isize ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_i8 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_string ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_struct ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_u32 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_u64 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_u8 ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_usize ... ok
Dec 14 21:33:18.211 INFO [stdout] test opaque::tests::test_unit ... ok
Dec 14 21:33:18.247 INFO [stdout] test opaque::tests::test_tuples ... ok
Dec 14 21:33:18.690 INFO [stdout] test opaque::tests::test_i16 ... ok
Dec 14 21:33:18.855 INFO [stdout] test opaque::tests::test_u16 ... ok
Dec 14 21:33:18.855 INFO [stdout] 
Dec 14 21:33:18.855 INFO [stdout] test result: ok. 112 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:33:18.855 INFO [stdout] 
Dec 14 21:33:18.863 INFO [stderr]    Doc-tests serialize
Dec 14 21:33:20.147 INFO [stdout] 
Dec 14 21:33:20.147 INFO [stdout] running 5 tests
Dec 14 21:33:23.001 INFO [stdout] test hex.rs - hex::[u8]::to_hex (line 32) ... ok
Dec 14 21:33:23.150 INFO [stdout] test json.rs - json (line 114) ... ok
Dec 14 21:33:23.407 INFO [stdout] test hex.rs - hex::str::from_hex (line 103) ... ok
Dec 14 21:33:23.903 INFO [stdout] test json.rs - json (line 154) ... ok
Dec 14 21:33:24.127 INFO [stdout] test json.rs - json (line 79) ... ok
Dec 14 21:33:24.128 INFO [stdout] 
Dec 14 21:33:24.128 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:33:24.128 INFO [stdout] 
Dec 14 21:33:24.148 INFO [stderr] su: No module specific data is present
Dec 14 21:33:25.318 INFO running `"docker" "inspect" "84347e558421abd9d1989077b2f80edad71ab39e30700a26b32fc9266705168d"`
Dec 14 21:33:25.691 INFO running `"docker" "rm" "-f" "84347e558421abd9d1989077b2f80edad71ab39e30700a26b32fc9266705168d"`
Dec 14 21:33:26.067 INFO [stdout] 84347e558421abd9d1989077b2f80edad71ab39e30700a26b32fc9266705168d