[INFO] fetching crate dicom-core 0.4.0...
[INFO] testing dicom-core-0.4.0 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate dicom-core 0.4.0 into /workspace/builds/worker-8/source
[INFO] validating manifest of crates.io crate dicom-core 0.4.0 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate dicom-core 0.4.0
[INFO] finished tweaking crates.io crate dicom-core 0.4.0
[INFO] tweaked toml for crates.io crate dicom-core 0.4.0 written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 66136087f2670decfcde568c1e74a8b67d8d63edcaeb979b900cc21645574d58
[INFO] running `Command { std: "docker" "start" "-a" "66136087f2670decfcde568c1e74a8b67d8d63edcaeb979b900cc21645574d58", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "66136087f2670decfcde568c1e74a8b67d8d63edcaeb979b900cc21645574d58", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "66136087f2670decfcde568c1e74a8b67d8d63edcaeb979b900cc21645574d58", kill_on_drop: false }`
[INFO] [stdout] 66136087f2670decfcde568c1e74a8b67d8d63edcaeb979b900cc21645574d58
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bbfcd95a7beafee63696572e1ae83e89f890df2f1662663bfacc1ff9a8e8f2cf
[INFO] running `Command { std: "docker" "start" "-a" "bbfcd95a7beafee63696572e1ae83e89f890df2f1662663bfacc1ff9a8e8f2cf", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling safe-transmute v0.11.2
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling itertools v0.10.1
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling snafu-derive v0.6.10
[INFO] [stderr]    Compiling snafu v0.6.10
[INFO] [stderr]    Compiling dicom-core v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.22s
[INFO] running `Command { std: "docker" "inspect" "bbfcd95a7beafee63696572e1ae83e89f890df2f1662663bfacc1ff9a8e8f2cf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bbfcd95a7beafee63696572e1ae83e89f890df2f1662663bfacc1ff9a8e8f2cf", kill_on_drop: false }`
[INFO] [stdout] bbfcd95a7beafee63696572e1ae83e89f890df2f1662663bfacc1ff9a8e8f2cf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 27b9876f6ed883e88b1b6265328892e9d4ca84f7f95a1d1d4f525460afd5a2f2
[INFO] running `Command { std: "docker" "start" "-a" "27b9876f6ed883e88b1b6265328892e9d4ca84f7f95a1d1d4f525460afd5a2f2", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling dicom-core v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.96s
[INFO] running `Command { std: "docker" "inspect" "27b9876f6ed883e88b1b6265328892e9d4ca84f7f95a1d1d4f525460afd5a2f2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "27b9876f6ed883e88b1b6265328892e9d4ca84f7f95a1d1d4f525460afd5a2f2", kill_on_drop: false }`
[INFO] [stdout] 27b9876f6ed883e88b1b6265328892e9d4ca84f7f95a1d1d4f525460afd5a2f2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 142575836fdb90865a465b8788e6e7cc69f48406d84d9878a2b3bfe94a8ffb51
[INFO] running `Command { std: "docker" "start" "-a" "142575836fdb90865a465b8788e6e7cc69f48406d84d9878a2b3bfe94a8ffb51", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/dicom_core-f09d354db72b7771)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test dictionary::tests::test_parse_tag_range ... ok
[INFO] [stdout] test header::tests::get_date_value ... ok
[INFO] [stdout] test header::tests::create_data_element_from_primitive ... ok
[INFO] [stdout] test header::tests::tag_from_u16_array ... ok
[INFO] [stdout] test header::tests::tag_from_u16_pair ... ok
[INFO] [stdout] test header::tests::to_clean_string ... ok
[INFO] [stdout] test util::tests::seek_interval_writing ... ok
[INFO] [stdout] test tests::macro_dicom_value ... ok
[INFO] [stdout] test util::tests::seek_interval_writing_here ... ok
[INFO] [stdout] test value::deserialize::tests::test_parse_date ... ok
[INFO] [stdout] test value::deserialize::tests::test_datetime ... ok
[INFO] [stdout] test value::deserialize::tests::test_time ... ok
[INFO] [stdout] test value::primitive::tests::calculate_byte_len ... ok
[INFO] [stdout] test value::primitive::tests::eq_ignores_multi_variants ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_get ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_clean_str ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_bytes ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_date ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_int ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_datetime ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_multi_floats ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_str ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_multi_int ... ok
[INFO] [stdout] test value::serialize::test::test_encode_date ... ok
[INFO] [stdout] test value::primitive::tests::primitive_value_to_time ... ok
[INFO] [stdout] test value::serialize::test::test_encode_datetime ... ok
[INFO] [stdout] test value::serialize::test::test_encode_time ... ok
[INFO] [stdout] test value::tests::getters ... ok
[INFO] [stdout] test value::tests::to_float ... ok
[INFO] [stdout] test value::tests::to_int ... ok
[INFO] [stdout] test value::primitive::tests::eq_str ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests dicom-core
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test src/header.rs - header::Length (line 945) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_float32 (line 1143) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_date (line 1911) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_date (line 1839) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_str (line 475) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_float32 (line 1304) ... ok
[INFO] [stdout] test src/lib.rs - dicom_value (line 79) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_clean_str (line 631) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_datetime (line 2140) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_time (line 2057) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue (line 158) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_time (line 1989) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_bytes (line 711) ... ok
[INFO] [stdout] test src/header.rs - header::Length (line 929) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_float64 (line 1493) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_str (line 533) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_datetime (line 2223) ... ok
[INFO] [stdout] test src/lib.rs - dicom_value (line 66) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_int (line 804) ... ok
[INFO] [stdout] test src/lib.rs - dicom_value (line 104) ... ok
[INFO] [stdout] test src/header.rs - header::Length (line 937) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_bytes (line 725) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_float64 (line 1654) ... ok
[INFO] [stdout] test src/value/primitive.rs - value::primitive::PrimitiveValue::to_multi_int (line 965) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.42s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "142575836fdb90865a465b8788e6e7cc69f48406d84d9878a2b3bfe94a8ffb51", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "142575836fdb90865a465b8788e6e7cc69f48406d84d9878a2b3bfe94a8ffb51", kill_on_drop: false }`
[INFO] [stdout] 142575836fdb90865a465b8788e6e7cc69f48406d84d9878a2b3bfe94a8ffb51