[INFO] crate bson 0.13.0 is already in cache
[INFO] extracting crate bson 0.13.0 into work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/bson/0.13.0
[INFO] extracting crate bson 0.13.0 into work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/bson/0.13.0
[INFO] validating manifest of bson-0.13.0 on toolchain master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of bson-0.13.0 on toolchain try#7fea0229842e79db1159ea58ad9a653b288efee9
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing bson-0.13.0
[INFO] finished frobbing bson-0.13.0
[INFO] frobbed toml for bson-0.13.0 written to work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/bson/0.13.0/Cargo.toml
[INFO] started frobbing bson-0.13.0
[INFO] finished frobbing bson-0.13.0
[INFO] frobbed toml for bson-0.13.0 written to work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/bson/0.13.0/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing bson-0.13.0 against master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54 for pr-57967
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-1/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/bson/0.13.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "build" "--frozen"`
[INFO] [stdout] 5b7bfc27047550f67324dd53c7aba01973744edef06789b14ecd8e414a615e85
[INFO] running `"docker" "start" "-a" "5b7bfc27047550f67324dd53c7aba01973744edef06789b14ecd8e414a615e85"`
[INFO] [stderr]    Compiling bson v0.13.0 (/opt/crater/workdir)
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]  --> src/oid.rs:5:48
[INFO] [stderr]   |
[INFO] [stderr] 5 | use std::sync::atomic::{AtomicUsize, Ordering, ATOMIC_USIZE_INIT};
[INFO] [stderr]   |                                                ^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> src/oid.rs:30:35
[INFO] [stderr]    |
[INFO] [stderr] 30 | static OID_COUNTER: AtomicUsize = ATOMIC_USIZE_INIT;
[INFO] [stderr]    |                                   ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.53s
[INFO] running `"docker" "inspect" "5b7bfc27047550f67324dd53c7aba01973744edef06789b14ecd8e414a615e85"`
[INFO] running `"docker" "rm" "-f" "5b7bfc27047550f67324dd53c7aba01973744edef06789b14ecd8e414a615e85"`
[INFO] [stdout] 5b7bfc27047550f67324dd53c7aba01973744edef06789b14ecd8e414a615e85
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-1/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/bson/0.13.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 1ca2063c693d48fd03a6ccbfeeffc11d37b48ea37a4a8ec7da41c1799f999e6d
[INFO] running `"docker" "start" "-a" "1ca2063c693d48fd03a6ccbfeeffc11d37b48ea37a4a8ec7da41c1799f999e6d"`
[INFO] [stderr]    Compiling bson v0.13.0 (/opt/crater/workdir)
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]  --> src/oid.rs:5:48
[INFO] [stderr]   |
[INFO] [stderr] 5 | use std::sync::atomic::{AtomicUsize, Ordering, ATOMIC_USIZE_INIT};
[INFO] [stderr]   |                                                ^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> src/oid.rs:30:35
[INFO] [stderr]    |
[INFO] [stderr] 30 | static OID_COUNTER: AtomicUsize = ATOMIC_USIZE_INIT;
[INFO] [stderr]    |                                   ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `tmp`
[INFO] [stderr]  --> examples/test.rs:7:9
[INFO] [stderr]   |
[INFO] [stderr] 7 |     let tmp = bson::to_bson(&map).unwrap();
[INFO] [stderr]   |         ^^^ help: consider prefixing with an underscore: `_tmp`
[INFO] [stderr]   |
[INFO] [stderr]   = note: #[warn(unused_variables)] on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.61s
[INFO] running `"docker" "inspect" "1ca2063c693d48fd03a6ccbfeeffc11d37b48ea37a4a8ec7da41c1799f999e6d"`
[INFO] running `"docker" "rm" "-f" "1ca2063c693d48fd03a6ccbfeeffc11d37b48ea37a4a8ec7da41c1799f999e6d"`
[INFO] [stdout] 1ca2063c693d48fd03a6ccbfeeffc11d37b48ea37a4a8ec7da41c1799f999e6d
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-1/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/bson/0.13.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "test" "--frozen"`
[INFO] [stdout] bbaccab0a362f96bbb5c6198a10b09940c7a6e841c796de694d3ea195591e3d5
[INFO] running `"docker" "start" "-a" "bbaccab0a362f96bbb5c6198a10b09940c7a6e841c796de694d3ea195591e3d5"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/bson-d5d222eb3b9484ff
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test oid::pid_generation ... ok
[INFO] [stdout] test oid::test_debug ... ok
[INFO] [stdout] test oid::count_generated_is_big_endian ... ok
[INFO] [stdout] test oid::test_display ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/lib-e863bc05b73599e1
[INFO] [stdout] 
[INFO] [stdout] running 52 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_invalid_utf8_string_issue64 ... ok
[INFO] [stdout] test modules::bson::to_json ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_binary_generic ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_i32 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_i64 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_javascript_code ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_floating_point ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_null ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_object_id ... 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_javascript_code_with_scope ... ok
[INFO] [stdout] test modules::encoder_decoder::test_decode_multiply_overflows_issue64 ... ok
[INFO] [stdout] test modules::encoder_decoder::test_decode_utc_date_time_overflows ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_utc_date_time ... 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::macros::standard_format ... ok
[INFO] [stdout] test modules::macros::rocket_format ... 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_decode_utf8_string ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_utf8_string_invalid ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_symbol ... ok
[INFO] [stdout] test modules::oid::timestamp ... ok
[INFO] [stdout] test modules::oid::string_oid ... ok
[INFO] [stdout] test modules::oid::oid_not_equals ... ok
[INFO] [stdout] test modules::oid::increasing ... ok
[INFO] [stdout] test modules::oid::timestamp_is_big_endian ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_document ... ok
[INFO] [stdout] test modules::ordered::remove ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_boolean ... ok
[INFO] [stdout] test modules::oid::oid_equals ... ok
[INFO] [stdout] test modules::ser::floating_point ... ok
[INFO] [stdout] test modules::encoder_decoder::test_encode_decode_array ... ok
[INFO] [stdout] test modules::ser::int32 ... ok
[INFO] [stdout] test modules::ser::arr ... ok
[INFO] [stdout] test modules::ser::boolean ... ok
[INFO] [stdout] test modules::ordered::ordered_insert_shorthand ... ok
[INFO] [stdout] test modules::ser::oid ... ok
[INFO] [stdout] test modules::ser::string ... ok
[INFO] [stdout] test modules::ser::uint16 ... 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] test modules::ser::int64 ... ok
[INFO] [stdout] test modules::ser::uint32 ... ok
[INFO] [stdout] test modules::ordered::entry ... ok
[INFO] [stdout] test modules::ordered::ordered_insert ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stderr]      Running /opt/crater/target/debug/deps/serde-e0d1aa892521c895
[INFO] [stdout] test test_byte_vec ... ok
[INFO] [stdout] test test_de_map ... ok
[INFO] [stdout] test test_compat_u2f ... ok
[INFO] [stdout] test test_de_timestamp ... ok
[INFO] [stdout] test test_ser_vec ... ok
[INFO] [stdout] test test_ser_timestamp ... ok
[INFO] [stdout] test test_serde_tuple_struct ... ok
[INFO] [stdout] test test_serde_tuple_variant ... ok
[INFO] [stdout] test test_ser_datetime ... ok
[INFO] [stdout] test test_serde_newtype_variant ... ok
[INFO] [stdout] test test_ser_map ... ok
[INFO] [stdout] test test_de_vec ... ok
[INFO] [stdout] test test_serde_bytes ... ok
[INFO] [stderr]    Doc-tests bson
[INFO] [stdout] test test_serde_newtype_struct ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/bson.rs - bson::TimeStamp (line 576) ... ignored
[INFO] [stdout] test src/bson.rs - bson::UtcDateTime (line 597) ... 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" "bbaccab0a362f96bbb5c6198a10b09940c7a6e841c796de694d3ea195591e3d5"`
[INFO] running `"docker" "rm" "-f" "bbaccab0a362f96bbb5c6198a10b09940c7a6e841c796de694d3ea195591e3d5"`
[INFO] [stdout] bbaccab0a362f96bbb5c6198a10b09940c7a6e841c796de694d3ea195591e3d5