[INFO] fetching crate kamadak-exif 0.6.1...
[INFO] testing kamadak-exif-0.6.1 against master#9e136a30a965bf4e63f03095c57df7257bf96fd6 for pr-134530
[INFO] extracting crate kamadak-exif 0.6.1 into /workspace/builds/worker-3-tc1/source
[INFO] validating manifest of crates.io crate kamadak-exif 0.6.1 on toolchain 9e136a30a965bf4e63f03095c57df7257bf96fd6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate kamadak-exif 0.6.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate kamadak-exif 0.6.1
[INFO] tweaked toml for crates.io crate kamadak-exif 0.6.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] crate crates.io crate kamadak-exif 0.6.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded mutate_once v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] dbb435693c90f5dc8174dc48c8fd2ffff19f97c19b923dc58c72238a81aa7328
[INFO] running `Command { std: "docker" "start" "-a" "dbb435693c90f5dc8174dc48c8fd2ffff19f97c19b923dc58c72238a81aa7328", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dbb435693c90f5dc8174dc48c8fd2ffff19f97c19b923dc58c72238a81aa7328", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dbb435693c90f5dc8174dc48c8fd2ffff19f97c19b923dc58c72238a81aa7328", kill_on_drop: false }`
[INFO] [stdout] dbb435693c90f5dc8174dc48c8fd2ffff19f97c19b923dc58c72238a81aa7328
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 61b1e6a6403a5179315f7d39d609e8c6d62233b78021e360e0130d51e8ca5395
[INFO] running `Command { std: "docker" "start" "-a" "61b1e6a6403a5179315f7d39d609e8c6d62233b78021e360e0130d51e8ca5395", kill_on_drop: false }`
[INFO] [stderr]    Compiling mutate_once v0.1.1
[INFO] [stderr]    Compiling kamadak-exif v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.12s
[INFO] running `Command { std: "docker" "inspect" "61b1e6a6403a5179315f7d39d609e8c6d62233b78021e360e0130d51e8ca5395", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61b1e6a6403a5179315f7d39d609e8c6d62233b78021e360e0130d51e8ca5395", kill_on_drop: false }`
[INFO] [stdout] 61b1e6a6403a5179315f7d39d609e8c6d62233b78021e360e0130d51e8ca5395
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ed049519a44ce2e18a1149aaa4c5c09fecd61c8f1869d2e02a3a0ccdab23fa6e
[INFO] running `Command { std: "docker" "start" "-a" "ed049519a44ce2e18a1149aaa4c5c09fecd61c8f1869d2e02a3a0ccdab23fa6e", kill_on_drop: false }`
[INFO] [stderr]    Compiling kamadak-exif v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.88s
[INFO] running `Command { std: "docker" "inspect" "ed049519a44ce2e18a1149aaa4c5c09fecd61c8f1869d2e02a3a0ccdab23fa6e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ed049519a44ce2e18a1149aaa4c5c09fecd61c8f1869d2e02a3a0ccdab23fa6e", kill_on_drop: false }`
[INFO] [stdout] ed049519a44ce2e18a1149aaa4c5c09fecd61c8f1869d2e02a3a0ccdab23fa6e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a3556490890bab53328d646e8497d2b65486f00501d7abce73b61b3b8f9689b1
[INFO] running `Command { std: "docker" "start" "-a" "a3556490890bab53328d646e8497d2b65486f00501d7abce73b61b3b8f9689b1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/exif-ce9d42b82dad4752)
[INFO] [stdout] 
[INFO] [stdout] running 94 tests
[INFO] [stdout] test endian::tests::dispatch ... ok
[INFO] [stdout] test endian::tests::loadu16 ... ok
[INFO] [stdout] test endian::tests::loadu32 ... ok
[INFO] [stdout] test endian::tests::loadu64 ... ok
[INFO] [stdout] test endian::tests::static_dispatch ... ok
[INFO] [stdout] test endian::tests::writeu16 ... ok
[INFO] [stdout] test endian::tests::writeu64 ... ok
[INFO] [stdout] test isobmff::tests::box_splitter ... ok
[INFO] [stdout] test endian::tests::writeu32 ... ok
[INFO] [stdout] test error::tests::is_send_sync_static ... ok
[INFO] [stdout] test isobmff::tests::bad_exif_data_block ... ok
[INFO] [stdout] test isobmff::tests::extract ... ok
[INFO] [stdout] test isobmff::tests::is_heif_test ... ok
[INFO] [stdout] test isobmff::tests::parser_box_header ... ok
[INFO] [stdout] test jpeg::tests::empty ... ok
[INFO] [stdout] test isobmff::tests::unknown_before_ftyp ... ok
[INFO] [stdout] test jpeg::tests::no_exif ... ok
[INFO] [stdout] test reader::tests::png ... ok
[INFO] [stdout] test reader::tests::webp ... ok
[INFO] [stdout] test jpeg::tests::non_empty ... ok
[INFO] [stdout] test reader::tests::yaminabe ... ok
[INFO] [stdout] test jpeg::tests::out_of_sync ... ok
[INFO] [stdout] test jpeg::tests::truncated ... ok
[INFO] [stdout] test png::tests::empty ... ok
[INFO] [stdout] test png::tests::no_exif ... ok
[INFO] [stdout] test png::tests::non_empty ... ok
[INFO] [stdout] test png::tests::truncated ... ok
[INFO] [stdout] test reader::tests::continue_on_error ... ok
[INFO] [stdout] test reader::tests::display_value_with_unit ... ok
[INFO] [stdout] test reader::tests::get_field ... ok
[INFO] [stdout] test reader::tests::heif ... ok
[INFO] [stdout] test tag::tests::default_value ... ok
[INFO] [stdout] test tag::tests::disp_val_sub ... ok
[INFO] [stdout] test tag::tests::tag_constant_in_pattern ... ok
[INFO] [stdout] test tag::tests::tag_fmt_display ... ok
[INFO] [stdout] test tiff::tests::continue_on_error ... ok
[INFO] [stdout] test tiff::tests::date_time ... ok
[INFO] [stdout] test tiff::tests::display_value_with_unit ... ok
[INFO] [stdout] test tiff::tests::in_convert ... ok
[INFO] [stdout] test tiff::tests::in_display ... ok
[INFO] [stdout] test tiff::tests::inf_loop_by_exif_next ... ok
[INFO] [stdout] test tiff::tests::no_borrow_no_move ... ok
[INFO] [stdout] test tiff::tests::inf_loop_by_next ... ok
[INFO] [stdout] test tiff::tests::truncated ... ok
[INFO] [stdout] test tiff::tests::unknown_field ... ok
[INFO] [stdout] test util::tests::discard_exact ... ok
[INFO] [stdout] test tiff::tests::parse_ifd_entry ... ok
[INFO] [stdout] test util::tests::read16_len ... ok
[INFO] [stdout] test value::tests::as_uint ... ok
[INFO] [stdout] test value::tests::ascii ... ok
[INFO] [stdout] test util::tests::atou16_misc ... ok
[INFO] [stdout] test value::tests::double ... ok
[INFO] [stdout] test value::tests::byte ... ok
[INFO] [stdout] test value::tests::float ... ok
[INFO] [stdout] test util::tests::read8_len ... ok
[INFO] [stdout] test value::tests::get_uint ... ok
[INFO] [stdout] test value::tests::iter_uint ... ok
[INFO] [stdout] test value::tests::ratioanl_f64 ... ok
[INFO] [stdout] test value::tests::iter_uint_is_exact_size_iter ... ok
[INFO] [stdout] test value::tests::rational ... ok
[INFO] [stdout] test value::tests::rational_fmt_display ... ok
[INFO] [stdout] test value::tests::long ... ok
[INFO] [stdout] test value::tests::sbyte ... ok
[INFO] [stdout] test value::tests::short ... ok
[INFO] [stdout] test value::tests::slong ... ok
[INFO] [stdout] test value::tests::rational_f32 ... ok
[INFO] [stdout] test value::tests::srational ... ok
[INFO] [stdout] test value::tests::srational_fmt_display ... ok
[INFO] [stdout] test value::tests::sshort ... ok
[INFO] [stdout] test webp::tests::no_exif ... ok
[INFO] [stdout] test value::tests::undefined ... ok
[INFO] [stdout] test value::tests::unknown ... ok
[INFO] [stdout] test webp::tests::non_empty ... ok
[INFO] [stdout] test value::tests::value_fmt_debug ... ok
[INFO] [stdout] test webp::tests::odd_at_last_without_padding ... ok
[INFO] [stdout] test webp::tests::empty ... ok
[INFO] [stdout] test webp::tests::out_of_toplevel_chunk ... ok
[INFO] [stdout] test webp::tests::overflowing_parent ... ok
[INFO] [stdout] test webp::tests::read_first ... ok
[INFO] [stdout] test webp::tests::truncated ... ok
[INFO] [stdout] test writer::tests::compose_field_value ... ok
[INFO] [stdout] test writer::tests::empty_file ... ok
[INFO] [stdout] test writer::tests::missing_primary ... ok
[INFO] [stdout] test writer::tests::primary ... ok
[INFO] [stdout] test writer::tests::primary_thumbnail_and_2nd ... ok
[INFO] [stdout] test writer::tests::thumbnail_tiff ... ok
[INFO] [stdout] test writer::tests::write_twice ... ok
[INFO] [stdout] test writer::tests::primary_and_thumbnail ... ok
[INFO] [stdout] test writer::tests::primary_tiff_tiled ... ok
[INFO] [stdout] test writer::tests::primary_exif_only ... ok
[INFO] [stdout] test writer::tests::thumbnail_jpeg ... ok
[INFO] [stdout] test endian::tests::wrap_around - should panic ... ok
[INFO] [stdout] test endian::tests::out_of_range - should panic ... ok
[INFO] [stdout] test value::tests::short_oor - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 94 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/platform.rs (/opt/rustwide/target/debug/deps/platform-1d485405ccfa60fc)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test size_of_usize ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/rwrcmp.rs (/opt/rustwide/target/debug/deps/rwrcmp-922883273aef3766)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test exif_heic ... ok
[INFO] [stdout] test exif_tif ... ok
[INFO] [stdout] test exif_jpg ... ok
[INFO] [stdout] test exif_png ... ok
[INFO] [stdout] test exif_webp ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests exif
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 100) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 109) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 148) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 59) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 85) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 89) ... ignored
[INFO] [stdout] test src/tag.rs - tag::Tag::context (line 65) ... ok
[INFO] [stdout] test src/value.rs - value::Value::as_uint (line 143) ... ok
[INFO] [stdout] test src/tiff.rs - tiff::In (line 119) ... ok
[INFO] [stdout] test src/tag.rs - tag::Tag::number (line 78) ... ok
[INFO] [stdout] test src/tiff.rs - tiff::Field::display_value (line 444) ... ok
[INFO] [stdout] test src/value.rs - value::Value::display_as (line 86) ... ok
[INFO] [stdout] test src/tiff.rs - tiff::DateTime (line 329) ... ok
[INFO] [stdout] test src/reader.rs - reader::Reader::continue_on_error (line 87) ... ok
[INFO] [stdout] test src/reader.rs - reader::Reader (line 44) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 67) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 139) ... ok
[INFO] [stdout] test src/lib.rs - (line 39) ... ok
[INFO] [stdout] test src/reader.rs - reader::Exif (line 164) ... ok
[INFO] [stdout] test src/lib.rs - (line 58) ... ok
[INFO] [stdout] test src/writer.rs - writer::Writer (line 40) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 117) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 6 ignored; 0 measured; 0 filtered out; finished in 0.98s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a3556490890bab53328d646e8497d2b65486f00501d7abce73b61b3b8f9689b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a3556490890bab53328d646e8497d2b65486f00501d7abce73b61b3b8f9689b1", kill_on_drop: false }`
[INFO] [stdout] a3556490890bab53328d646e8497d2b65486f00501d7abce73b61b3b8f9689b1