[INFO] fetching crate zip 0.5.13...
[INFO] testing zip-0.5.13 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate zip 0.5.13 into /workspace/builds/worker-46/source
[INFO] validating manifest of crates.io crate zip 0.5.13 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate zip 0.5.13
[INFO] finished tweaking crates.io crate zip 0.5.13
[INFO] tweaked toml for crates.io crate zip 0.5.13 written to /workspace/builds/worker-46/source/Cargo.toml
[INFO] crate crates.io crate zip 0.5.13 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 10fbe8f3e4662c33d0f2380aa1c5ab5db88c9a9d0b3a510201f76e19d8facb16
[INFO] running `Command { std: "docker" "start" "-a" "10fbe8f3e4662c33d0f2380aa1c5ab5db88c9a9d0b3a510201f76e19d8facb16", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "10fbe8f3e4662c33d0f2380aa1c5ab5db88c9a9d0b3a510201f76e19d8facb16", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10fbe8f3e4662c33d0f2380aa1c5ab5db88c9a9d0b3a510201f76e19d8facb16", kill_on_drop: false }`
[INFO] [stdout] 10fbe8f3e4662c33d0f2380aa1c5ab5db88c9a9d0b3a510201f76e19d8facb16
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5635331c39174827b853834a0b0a2ddebf5f26910517b6b75dd5c5eecf952a99
[INFO] running `Command { std: "docker" "start" "-a" "5635331c39174827b853834a0b0a2ddebf5f26910517b6b75dd5c5eecf952a99", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.86
[INFO] [stderr]    Compiling syn v1.0.60
[INFO] [stderr]    Compiling pkg-config v0.3.19
[INFO] [stderr]    Compiling cc v1.0.67
[INFO] [stderr]    Compiling crc32fast v1.2.1
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling adler32 v1.2.0
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling miniz_oxide v0.3.7
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling flate2 v1.0.14
[INFO] [stderr]    Compiling bzip2-sys v0.1.10+1.0.8
[INFO] [stderr]    Compiling bzip2 v0.4.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.24
[INFO] [stderr]    Compiling thiserror v1.0.24
[INFO] [stderr]    Compiling zip v0.5.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.85s
[INFO] running `Command { std: "docker" "inspect" "5635331c39174827b853834a0b0a2ddebf5f26910517b6b75dd5c5eecf952a99", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5635331c39174827b853834a0b0a2ddebf5f26910517b6b75dd5c5eecf952a99", kill_on_drop: false }`
[INFO] [stdout] 5635331c39174827b853834a0b0a2ddebf5f26910517b6b75dd5c5eecf952a99
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7bd50d554ac0bc5ed7010870ebb48c09d60d5ddd510a8b2f800524e6f335395a
[INFO] running `Command { std: "docker" "start" "-a" "7bd50d554ac0bc5ed7010870ebb48c09d60d5ddd510a8b2f800524e6f335395a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling bencher v0.1.5
[INFO] [stderr]    Compiling walkdir v2.3.1
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling zip v0.5.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.44s
[INFO] running `Command { std: "docker" "inspect" "7bd50d554ac0bc5ed7010870ebb48c09d60d5ddd510a8b2f800524e6f335395a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7bd50d554ac0bc5ed7010870ebb48c09d60d5ddd510a8b2f800524e6f335395a", kill_on_drop: false }`
[INFO] [stdout] 7bd50d554ac0bc5ed7010870ebb48c09d60d5ddd510a8b2f800524e6f335395a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ab8496bd8e04ec07fd4d3977d89b4a72749ba3bae132148e81bd285e0d9d2648
[INFO] running `Command { std: "docker" "start" "-a" "ab8496bd8e04ec07fd4d3977d89b4a72749ba3bae132148e81bd285e0d9d2648", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/zip-31b0e5d4276325e8)
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test compression::test::to_display_fmt ... ok
[INFO] [stdout] test compression::test::to_eq_from ... ok
[INFO] [stdout] test cp437::test::ascii ... ok
[INFO] [stdout] test cp437::test::example_slice ... ok
[INFO] [stdout] test compression::test::from_eq_to ... ok
[INFO] [stdout] test cp437::test::example_vec ... ok
[INFO] [stdout] test cp437::test::to_char_valid ... ok
[INFO] [stdout] test crc32::test::test_byte_by_byte ... ok
[INFO] [stdout] test crc32::test::test_empty_reader ... ok
[INFO] [stdout] test crc32::test::test_zero_read ... ok
[INFO] [stdout] test read::test::file_and_dir_predicates ... ok
[INFO] [stdout] test read::test::invalid_offset ... ok
[INFO] [stdout] test read::test::invalid_offset2 ... ok
[INFO] [stdout] test read::test::zip64_with_leading_junk ... ok
[INFO] [stdout] test read::test::zip_clone ... ok
[INFO] [stdout] test read::test::zip_contents ... ok
[INFO] [stdout] test types::test::datetime_default ... ok
[INFO] [stdout] test types::test::datetime_max ... ok
[INFO] [stdout] test types::test::system ... ok
[INFO] [stdout] test types::test::datetime_from_time_bounds ... ok
[INFO] [stdout] test types::test::time_at_january ... ok
[INFO] [stdout] test types::test::time_conversion ... ok
[INFO] [stdout] test types::test::datetime_bounds ... ok
[INFO] [stdout] test types::test::time_out_of_bounds ... ok
[INFO] [stdout] test read::test::zip_read_streaming ... ok
[INFO] [stdout] test types::test::sanitize ... ok
[INFO] [stdout] test write::test::path_to_string ... ok
[INFO] [stdout] test write::test::write_empty_zip ... ok
[INFO] [stdout] test write::test::write_mimetype_zip ... ok
[INFO] [stderr]      Running tests/end_to_end.rs (/opt/rustwide/target/debug/deps/end_to_end-d42ce29c9a01e9fa)
[INFO] [stdout] test write::test::write_zip_dir ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test copy ... ok
[INFO] [stdout] test end_to_end ... ok
[INFO] [stdout] test append ... ok
[INFO] [stderr]      Running tests/invalid_date.rs (/opt/rustwide/target/debug/deps/invalid_date-dde1ba188154d9c7)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/zip64_large.rs (/opt/rustwide/target/debug/deps/zip64_large-e84532bf545c4032)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/zip_comment_garbage.rs (/opt/rustwide/target/debug/deps/zip_comment_garbage-0dd7a8fe6f550181)
[INFO] [stdout] running 1 test
[INFO] [stdout] test invalid_date ... 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 1 test
[INFO] [stdout] test zip64_large ... 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/zip_crypto.rs (/opt/rustwide/target/debug/deps/zip_crypto-7e67abbcfd98eded)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test correctly_handle_zip_with_garbage_after_comment ... 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]    Doc-tests zip
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test encrypted_file ... 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 6 tests
[INFO] [stdout] test src/write.rs - write::ZipWriter<W>::raw_copy_file (line 632) - compile ... ok
[INFO] [stdout] test src/result.rs - result::ZipError::PASSWORD_REQUIRED (line 38) - compile ... ok
[INFO] [stdout] test src/write.rs - write::ZipWriter<W>::raw_copy_file_rename (line 579) - compile ... ok
[INFO] [stdout] test src/read.rs - read::ZipArchive (line 34) - compile ... ok
[INFO] [stdout] test src/write.rs - write::ZipWriter (line 43) ... ok
[INFO] [stdout] test src/write.rs - write::ZipWriter<W>::start_file_with_extra_data (line 454) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.44s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "ab8496bd8e04ec07fd4d3977d89b4a72749ba3bae132148e81bd285e0d9d2648", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ab8496bd8e04ec07fd4d3977d89b4a72749ba3bae132148e81bd285e0d9d2648", kill_on_drop: false }`
[INFO] [stdout] ab8496bd8e04ec07fd4d3977d89b4a72749ba3bae132148e81bd285e0d9d2648