[INFO] fetching crate kamadak-exif 0.5.4...
[INFO] testing kamadak-exif-0.5.4 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate kamadak-exif 0.5.4 into /workspace/builds/worker-12/source
[INFO] validating manifest of crates.io crate kamadak-exif 0.5.4 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate kamadak-exif 0.5.4
[INFO] finished tweaking crates.io crate kamadak-exif 0.5.4
[INFO] tweaked toml for crates.io crate kamadak-exif 0.5.4 written to /workspace/builds/worker-12/source/Cargo.toml
[INFO] crate crates.io crate kamadak-exif 0.5.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cbd08498792ee3c3aae50940e543ff770159cc038f02ea89c17224c0f89472dd
[INFO] running `Command { std: "docker" "start" "-a" "cbd08498792ee3c3aae50940e543ff770159cc038f02ea89c17224c0f89472dd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cbd08498792ee3c3aae50940e543ff770159cc038f02ea89c17224c0f89472dd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cbd08498792ee3c3aae50940e543ff770159cc038f02ea89c17224c0f89472dd", kill_on_drop: false }`
[INFO] [stdout] cbd08498792ee3c3aae50940e543ff770159cc038f02ea89c17224c0f89472dd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9f2b3609adb349111a010ac4074d496a1209e4fa7c3543a3cb69255fa6e34ef9
[INFO] running `Command { std: "docker" "start" "-a" "9f2b3609adb349111a010ac4074d496a1209e4fa7c3543a3cb69255fa6e34ef9", kill_on_drop: false }`
[INFO] [stderr]    Compiling mutate_once v0.1.1
[INFO] [stderr]    Compiling kamadak-exif v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.89s
[INFO] running `Command { std: "docker" "inspect" "9f2b3609adb349111a010ac4074d496a1209e4fa7c3543a3cb69255fa6e34ef9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9f2b3609adb349111a010ac4074d496a1209e4fa7c3543a3cb69255fa6e34ef9", kill_on_drop: false }`
[INFO] [stdout] 9f2b3609adb349111a010ac4074d496a1209e4fa7c3543a3cb69255fa6e34ef9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f650b48ba5ecfa2ebbcb3202b4bafe239c44ef758b1899bbfea553719bc1dc13
[INFO] running `Command { std: "docker" "start" "-a" "f650b48ba5ecfa2ebbcb3202b4bafe239c44ef758b1899bbfea553719bc1dc13", kill_on_drop: false }`
[INFO] [stderr]    Compiling kamadak-exif v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.95s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/exif-e259e61447b05283)
[INFO] [stderr]   Executable tests/platform.rs (/opt/rustwide/target/debug/deps/platform-0e92a61d478008b6)
[INFO] [stderr]   Executable tests/rwrcmp.rs (/opt/rustwide/target/debug/deps/rwrcmp-cf868537fa250e43)
[INFO] running `Command { std: "docker" "inspect" "f650b48ba5ecfa2ebbcb3202b4bafe239c44ef758b1899bbfea553719bc1dc13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f650b48ba5ecfa2ebbcb3202b4bafe239c44ef758b1899bbfea553719bc1dc13", kill_on_drop: false }`
[INFO] [stdout] f650b48ba5ecfa2ebbcb3202b4bafe239c44ef758b1899bbfea553719bc1dc13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 616ed47f8da4c18ee91f4142b2d2f83a49aca1e84f84655ad26c28ec6697ec29
[INFO] running `Command { std: "docker" "start" "-a" "616ed47f8da4c18ee91f4142b2d2f83a49aca1e84f84655ad26c28ec6697ec29", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/exif-e259e61447b05283)
[INFO] [stdout] 
[INFO] [stdout] running 88 tests
[INFO] [stdout] test endian::tests::loadu64 ... ok
[INFO] [stdout] test endian::tests::dispatch ... ok
[INFO] [stdout] test endian::tests::loadu16 ... ok
[INFO] [stdout] test endian::tests::writeu16 ... ok
[INFO] [stdout] test endian::tests::static_dispatch ... ok
[INFO] [stdout] test endian::tests::loadu32 ... ok
[INFO] [stdout] test endian::tests::writeu32 ... ok
[INFO] [stdout] test isobmff::tests::parser_box_header ... ok
[INFO] [stdout] test isobmff::tests::unknown_before_ftyp ... ok
[INFO] [stdout] test isobmff::tests::box_splitter ... ok
[INFO] [stdout] test png::tests::no_exif ... ok
[INFO] [stdout] test png::tests::non_empty ... ok
[INFO] [stdout] test jpeg::tests::truncated ... ok
[INFO] [stdout] test png::tests::empty ... ok
[INFO] [stdout] test jpeg::tests::out_of_sync ... ok
[INFO] [stdout] test jpeg::tests::non_empty ... ok
[INFO] [stdout] test jpeg::tests::no_exif ... ok
[INFO] [stdout] test isobmff::tests::bad_exif_data_block ... ok
[INFO] [stdout] test isobmff::tests::is_heif_test ... ok
[INFO] [stdout] test endian::tests::writeu64 ... ok
[INFO] [stdout] test reader::tests::webp ... 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 isobmff::tests::extract ... ok
[INFO] [stdout] test reader::tests::display_value_with_unit ... ok
[INFO] [stdout] test reader::tests::png ... ok
[INFO] [stdout] test png::tests::truncated ... ok
[INFO] [stdout] test tiff::tests::date_time ... ok
[INFO] [stdout] test tag::tests::default_value ... ok
[INFO] [stdout] test jpeg::tests::empty ... ok
[INFO] [stdout] test reader::tests::get_field ... ok
[INFO] [stdout] test tiff::tests::in_convert ... ok
[INFO] [stdout] test reader::tests::heif ... ok
[INFO] [stdout] test tiff::tests::display_value_with_unit ... ok
[INFO] [stdout] test tiff::tests::inf_loop_by_exif_next ... ok
[INFO] [stdout] test tiff::tests::in_display ... ok
[INFO] [stdout] test tiff::tests::truncated ... 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::unknown_field ... ok
[INFO] [stdout] test util::tests::atou16_misc ... ok
[INFO] [stdout] test util::tests::read16_len ... ok
[INFO] [stdout] test util::tests::read8_len ... ok
[INFO] [stdout] test value::tests::byte ... ok
[INFO] [stdout] test value::tests::ascii ... ok
[INFO] [stdout] test value::tests::double ... ok
[INFO] [stdout] test value::tests::get_uint ... ok
[INFO] [stdout] test value::tests::iter_uint ... ok
[INFO] [stdout] test value::tests::float ... ok
[INFO] [stdout] test value::tests::iter_uint_is_exact_size_iter ... ok
[INFO] [stdout] test util::tests::discard_exact ... ok
[INFO] [stdout] test value::tests::long ... ok
[INFO] [stdout] test value::tests::ratioanl_f64 ... ok
[INFO] [stdout] test value::tests::rational ... ok
[INFO] [stdout] test value::tests::rational_f32 ... ok
[INFO] [stdout] test value::tests::rational_fmt_display ... ok
[INFO] [stdout] test value::tests::sbyte ... ok
[INFO] [stdout] test value::tests::slong ... ok
[INFO] [stdout] test value::tests::srational_fmt_display ... ok
[INFO] [stdout] test value::tests::sshort ... ok
[INFO] [stdout] test webp::tests::empty ... ok
[INFO] [stdout] test value::tests::short ... ok
[INFO] [stdout] test value::tests::srational ... ok
[INFO] [stdout] test value::tests::value_fmt_debug ... ok
[INFO] [stdout] test webp::tests::non_empty ... ok
[INFO] [stdout] test webp::tests::odd_at_last_without_padding ... ok
[INFO] [stdout] test webp::tests::out_of_toplevel_chunk ... ok
[INFO] [stdout] test webp::tests::read_first ... ok
[INFO] [stdout] test webp::tests::overflowing_parent ... ok
[INFO] [stdout] test writer::tests::empty_file ... ok
[INFO] [stdout] test writer::tests::compose_field_value ... ok
[INFO] [stdout] test writer::tests::missing_primary ... ok
[INFO] [stdout] test value::tests::undefined ... ok
[INFO] [stdout] test value::tests::unknown ... ok
[INFO] [stdout] test writer::tests::primary ... ok
[INFO] [stdout] test writer::tests::primary_and_thumbnail ... ok
[INFO] [stdout] test writer::tests::primary_exif_only ... ok
[INFO] [stdout] test writer::tests::write_twice ... ok
[INFO] [stdout] test writer::tests::thumbnail_jpeg ... ok
[INFO] [stdout] test writer::tests::thumbnail_tiff ... ok
[INFO] [stdout] test webp::tests::truncated ... ok
[INFO] [stdout] test writer::tests::primary_thumbnail_and_2nd ... ok
[INFO] [stdout] test writer::tests::primary_tiff_tiled ... ok
[INFO] [stdout] test webp::tests::no_exif ... 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. 88 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/platform.rs (/opt/rustwide/target/debug/deps/platform-0e92a61d478008b6)
[INFO] [stderr]      Running tests/rwrcmp.rs (/opt/rustwide/target/debug/deps/rwrcmp-cf868537fa250e43)
[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] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test exif_png ... ok
[INFO] [stdout] test exif_heic ... ok
[INFO] [stdout] test exif_tif ... ok
[INFO] [stderr]    Doc-tests exif
[INFO] [stdout] test exif_jpg ... 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.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 132) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 43) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 69) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 73) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 84) ... ignored
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 93) ... ignored
[INFO] [stdout] test src/tag.rs - tag::Tag::context (line 65) ... 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::DateTime (line 275) ... ok
[INFO] [stdout] test src/tiff.rs - tiff::Field::display_value (line 390) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 101) ... ok
[INFO] [stdout] test src/value.rs - value::Value::display_as (line 85) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 123) ... ok
[INFO] [stdout] test src/reader.rs - reader::Reader (line 44) ... ok
[INFO] [stdout] test src/lib.rs - (line 58) ... ok
[INFO] [stdout] test src/lib.rs - (line 39) ... ok
[INFO] [stdout] test src/reader.rs - reader::Exif (line 125) ... ok
[INFO] [stdout] test src/writer.rs - writer::Writer (line 40) ... ok
[INFO] [stdout] test src/doc.rs - doc::upgrade (line 51) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 6 ignored; 0 measured; 0 filtered out; finished in 1.07s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "616ed47f8da4c18ee91f4142b2d2f83a49aca1e84f84655ad26c28ec6697ec29", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "616ed47f8da4c18ee91f4142b2d2f83a49aca1e84f84655ad26c28ec6697ec29", kill_on_drop: false }`
[INFO] [stdout] 616ed47f8da4c18ee91f4142b2d2f83a49aca1e84f84655ad26c28ec6697ec29