[INFO] crate bson 0.14.0 is already in cache
[INFO] testing bson-0.14.0 against beta-2019-09-28 for beta-1.39-1
[INFO] extracting crate bson 0.14.0 into work/builds/worker-3/source
[INFO] validating manifest of crates.io crate bson 0.14.0 on toolchain beta-2019-09-28
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking crates.io crate bson 0.14.0
[INFO] finished tweaking crates.io crate bson 0.14.0
[INFO] tweaked toml for crates.io crate bson 0.14.0 written to work/builds/worker-3/source/Cargo.toml
[INFO] crate crates.io crate bson 0.14.0 already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "build" "--frozen"`
[INFO] [stdout] c58b48d9aa7c1ffb9f31c2e109d48fbd0ec618a16de5ede493e834ea147dbc14
[INFO] running `"docker" "start" "-a" "c58b48d9aa7c1ffb9f31c2e109d48fbd0ec618a16de5ede493e834ea147dbc14"`
[INFO] [stderr]    Compiling ryu v0.2.7
[INFO] [stderr]    Compiling itoa v0.4.3
[INFO] [stderr]    Compiling linked-hash-map v0.5.1
[INFO] [stderr]    Compiling chrono v0.4.6
[INFO] [stderr]    Compiling serde_json v1.0.39
[INFO] [stderr]    Compiling bson v0.14.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.55s
[INFO] running `"docker" "inspect" "c58b48d9aa7c1ffb9f31c2e109d48fbd0ec618a16de5ede493e834ea147dbc14"`
[INFO] running `"docker" "rm" "-f" "c58b48d9aa7c1ffb9f31c2e109d48fbd0ec618a16de5ede493e834ea147dbc14"`
[INFO] [stdout] c58b48d9aa7c1ffb9f31c2e109d48fbd0ec618a16de5ede493e834ea147dbc14
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen" "--no-run"`
[INFO] [stdout] da2d8cc4a3e72c0f2969b592fa0fa2d76d6bc4fe0dd1609a1a8a824b8f2e02dc
[INFO] running `"docker" "start" "-a" "da2d8cc4a3e72c0f2969b592fa0fa2d76d6bc4fe0dd1609a1a8a824b8f2e02dc"`
[INFO] [stderr]    Compiling syn v0.15.29
[INFO] [stderr]    Compiling quote v0.6.11
[INFO] [stderr]    Compiling serde_bytes v0.11.2
[INFO] [stderr]    Compiling serde_derive v1.0.89
[INFO] [stderr]    Compiling bson v0.14.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.59s
[INFO] running `"docker" "inspect" "da2d8cc4a3e72c0f2969b592fa0fa2d76d6bc4fe0dd1609a1a8a824b8f2e02dc"`
[INFO] running `"docker" "rm" "-f" "da2d8cc4a3e72c0f2969b592fa0fa2d76d6bc4fe0dd1609a1a8a824b8f2e02dc"`
[INFO] [stdout] da2d8cc4a3e72c0f2969b592fa0fa2d76d6bc4fe0dd1609a1a8a824b8f2e02dc
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen"`
[INFO] [stdout] d239991b5871ca837605d8da5e7965aab9f87cc6594f3e6021133aaf3a64f13c
[INFO] running `"docker" "start" "-a" "d239991b5871ca837605d8da5e7965aab9f87cc6594f3e6021133aaf3a64f13c"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/bson-e8c397f383be885b
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test oid::test_debug ... ok
[INFO] [stdout] test oid::test_display ... ok
[INFO] [stdout] test oid::count_generated_is_big_endian ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/lib-65a2245273c01aed
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test modules::bson::bson_default ... ok
[INFO] [stdout] test modules::bson::document_default ... ok
[INFO] [stdout] test modules::encoder_decoder::test_decode_multiply_overflows_issue64 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_decode_invalid_utf8_string_issue64 ... ok
[INFO] [stdout] test modules::bson::to_json ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_boolean ... ok
[INFO] [stdout] test modules::encoder_decoder::test_decode_utc_date_time_overflows ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_document ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_i32 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_javascript_code ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_binary_generic ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_array ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_i64 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_floating_point ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_object_id ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_null ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_symbol ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_javascript_code_with_scope ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_regexp ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_timestamp ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_utf8_string ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_utf8_string_invalid ... ok
[INFO] [stdout] test modules::encoder_decoder::test_illegal_size ... ok
[INFO] [stdout] test modules::macros::non_trailing_comma ... ok
[INFO] [stdout] test modules::macros::non_trailing_comma_with_rockets ... ok
[INFO] [stdout] test modules::macros::recursive_macro ... ok
[INFO] [stdout] test modules::oid::byte_string_oid ... ok
[INFO] [stdout] test modules::oid::deserialize ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_utc_date_time ... ok
[INFO] [stdout] test modules::macros::rocket_format ... ok
[INFO] [stdout] test modules::macros::standard_format ... ok
[INFO] [stdout] test modules::oid::string_oid ... ok
[INFO] [stdout] test modules::oid::timestamp ... ok
[INFO] [stdout] test modules::oid::timestamp_is_big_endian ... ok
[INFO] [stdout] test modules::oid::oid_equals ... ok
[INFO] [stdout] test modules::oid::oid_not_equals ... ok
[INFO] [stdout] test modules::oid::counter_increasing ... ok
[INFO] [stdout] test modules::ordered::entry ... ok
[INFO] [stdout] test modules::ordered::ordered_insert ... ok
[INFO] [stdout] test modules::ordered::ordered_insert_shorthand ... ok
[INFO] [stdout] test modules::ordered::remove ... ok
[INFO] [stdout] test modules::ser::arr ... ok
[INFO] [stdout] test modules::ser::boolean ... ok
[INFO] [stdout] test modules::ser::int64 ... ok
[INFO] [stdout] test modules::ser::floating_point ... ok
[INFO] [stdout] test modules::ser::int32 ... ok
[INFO] [stdout] test modules::ser::string ... ok
[INFO] [stdout] test modules::ser::uint16 ... ok
[INFO] [stdout] test modules::ser::uint32 ... ok
[INFO] [stdout] test modules::ser::oid ... ok
[INFO] [stdout] test modules::ser::uint64 ... ok
[INFO] [stdout] test modules::ser::uint8 ... ok
[INFO] [stdout] test modules::ordered::test_getters ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/serde-d1941011c621a8f7
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test test_byte_vec ... ok
[INFO] [stdout] test test_compat_u2f ... ok
[INFO] [stdout] test test_de_map ... ok
[INFO] [stdout] test test_de_vec ... ok
[INFO] [stdout] test test_de_timestamp ... ok
[INFO] [stdout] test test_ser_map ... ok
[INFO] [stdout] test test_ser_vec ... ok
[INFO] [stdout] test test_ser_timestamp ... ok
[INFO] [stdout] test test_ser_datetime ... ok
[INFO] [stdout] test test_serde_newtype_struct ... ok
[INFO] [stdout] test test_serde_bytes ... ok
[INFO] [stdout] test test_serde_newtype_variant ... ok
[INFO] [stdout] test test_serde_tuple_struct ... ok
[INFO] [stdout] test test_serde_tuple_variant ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests bson
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/bson.rs - bson::TimeStamp (line 721) ... ignored
[INFO] [stdout] test src/bson.rs - bson::UtcDateTime (line 742) ... ignored
[INFO] [stdout] test src/macros.rs - doc (line 225) ... ok
[INFO] [stdout] test src/macros.rs - bson (line 5) ... ok
[INFO] [stdout] test src/lib.rs -  (line 29) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "d239991b5871ca837605d8da5e7965aab9f87cc6594f3e6021133aaf3a64f13c"`
[INFO] running `"docker" "rm" "-f" "d239991b5871ca837605d8da5e7965aab9f87cc6594f3e6021133aaf3a64f13c"`
[INFO] [stdout] d239991b5871ca837605d8da5e7965aab9f87cc6594f3e6021133aaf3a64f13c