[INFO] fetching crate sftp 0.3.0...
[INFO] testing sftp-0.3.0 against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739-1
[INFO] extracting crate sftp 0.3.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate sftp 0.3.0
[INFO] finished tweaking crates.io crate sftp 0.3.0
[INFO] tweaked toml for crates.io crate sftp 0.3.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sftp 0.3.0 on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sftp 0.3.0 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 4e0cff6e0ab337abbed572b7f5bdf1decc93b867a560a8a6d7ac3abdf4f057ed
[INFO] running `Command { std: "docker" "start" "-a" "4e0cff6e0ab337abbed572b7f5bdf1decc93b867a560a8a6d7ac3abdf4f057ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4e0cff6e0ab337abbed572b7f5bdf1decc93b867a560a8a6d7ac3abdf4f057ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4e0cff6e0ab337abbed572b7f5bdf1decc93b867a560a8a6d7ac3abdf4f057ed", kill_on_drop: false }`
[INFO] [stdout] 4e0cff6e0ab337abbed572b7f5bdf1decc93b867a560a8a6d7ac3abdf4f057ed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8787175ad3b07d5356a0956cab11a4fa0a5c68843461b72da06df1e9200b121b
[INFO] running `Command { std: "docker" "start" "-a" "8787175ad3b07d5356a0956cab11a4fa0a5c68843461b72da06df1e9200b121b", kill_on_drop: false }`
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling endian-type v0.2.0
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling unicode-width v0.2.2
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling unicode-segmentation v1.13.2
[INFO] [stderr]    Compiling radix_trie v0.3.0
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling rustyline v18.0.0
[INFO] [stderr]    Compiling sftp v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.20s
[INFO] running `Command { std: "docker" "inspect" "8787175ad3b07d5356a0956cab11a4fa0a5c68843461b72da06df1e9200b121b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8787175ad3b07d5356a0956cab11a4fa0a5c68843461b72da06df1e9200b121b", kill_on_drop: false }`
[INFO] [stdout] 8787175ad3b07d5356a0956cab11a4fa0a5c68843461b72da06df1e9200b121b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 71c2e42dc0d4dc702c8576bf265ec02dc426f4ce3b16942887dca6306f594dab
[INFO] running `Command { std: "docker" "start" "-a" "71c2e42dc0d4dc702c8576bf265ec02dc426f4ce3b16942887dca6306f594dab", kill_on_drop: false }`
[INFO] [stderr]    Compiling sftp v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.78s
[INFO] running `Command { std: "docker" "inspect" "71c2e42dc0d4dc702c8576bf265ec02dc426f4ce3b16942887dca6306f594dab", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "71c2e42dc0d4dc702c8576bf265ec02dc426f4ce3b16942887dca6306f594dab", kill_on_drop: false }`
[INFO] [stdout] 71c2e42dc0d4dc702c8576bf265ec02dc426f4ce3b16942887dca6306f594dab
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8f807fb620f8ff32c56654a89d73ec73242f843093d1e3a746434fb199a9a297
[INFO] running `Command { std: "docker" "start" "-a" "8f807fb620f8ff32c56654a89d73ec73242f843093d1e3a746434fb199a9a297", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sftp-e18080bbddd1d4df)
[INFO] [stdout] 
[INFO] [stdout] running 59 tests
[INFO] [stdout] test protocol::tests::attributes_roundtrip_all_fields ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_allocation_size ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_bits ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_acl ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_empty ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_ownergroup ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_extended ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_link_count_untranslated ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_size_perms ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_times_with_subseconds ... ok
[INFO] [stdout] test protocol::tests::build_block_unblock_layout ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_text_and_mime ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_times_seconds_only ... ok
[INFO] [stdout] test protocol::tests::build_extended_layout ... ok
[INFO] [stdout] test protocol::tests::attributes_roundtrip_uidgid ... ok
[INFO] [stdout] test protocol::tests::build_handle_only_layout ... ok
[INFO] [stdout] test protocol::tests::build_link_sets_flag_byte ... ok
[INFO] [stdout] test protocol::tests::build_handle_and_flags_layout ... ok
[INFO] [stdout] test protocol::tests::build_open_layout_includes_flags_and_attrs ... ok
[INFO] [stdout] test protocol::tests::build_pread_layout ... ok
[INFO] [stdout] test protocol::tests::build_path_only_layout ... ok
[INFO] [stdout] test protocol::tests::build_pwrite_layout ... ok
[INFO] [stdout] test protocol::tests::build_realpath_optional_fields ... ok
[INFO] [stdout] test protocol::tests::build_rename_default_flags ... ok
[INFO] [stdout] test protocol::tests::build_path_and_flags_layout ... ok
[INFO] [stdout] test protocol::tests::build_rename_honours_explicit_flags ... ok
[INFO] [stdout] test protocol::tests::build_two_paths_layout ... ok
[INFO] [stdout] test protocol::tests::error_conversion_preserves_kind ... ok
[INFO] [stdout] test protocol::tests::expect_attrs_rejects_ok_status_without_panic ... ok
[INFO] [stdout] test protocol::tests::expect_data_rejects_ok_status_without_panic ... ok
[INFO] [stdout] test protocol::tests::expect_handle_passes_through_status_error ... ok
[INFO] [stdout] test protocol::tests::expect_handle_rejects_ok_status_without_panic ... ok
[INFO] [stdout] test protocol::tests::parse_name_roundtrip ... ok
[INFO] [stdout] test protocol::tests::parse_readdir_roundtrip ... ok
[INFO] [stdout] test protocol::tests::expect_handle_rejects_unexpected_cmd ... ok
[INFO] [stdout] test protocol::tests::parse_status_eof ... ok
[INFO] [stdout] test protocol::tests::parse_handle_roundtrip ... ok
[INFO] [stdout] test protocol::tests::parse_status_ok ... ok
[INFO] [stdout] test protocol::tests::parse_version_reads_extensions ... ok
[INFO] [stdout] test protocol::tests::request_id_roundtrip ... ok
[INFO] [stdout] test protocol::tests::split_request_id_rejects_short_buffer ... ok
[INFO] [stdout] test protocol::tests::parse_version_rejects_non_3 ... ok
[INFO] [stdout] test sync::tests::sync_extended_payload_and_none ... ok
[INFO] [stdout] test sync::tests::sync_open_returns_handle ... ok
[INFO] [stdout] test sync::tests::sync_opendir_readdir ... ok
[INFO] [stdout] test sync::tests::sync_init_fails_on_wrong_response ... ok
[INFO] [stdout] test sync::tests::sync_handshake_reads_version ... ok
[INFO] [stdout] test sync::tests::sync_lstat_and_fstat ... ok
[INFO] [stdout] test sync::tests::sync_pread_returns_data ... ok
[INFO] [stdout] test sync::tests::sync_pwrite_ok ... ok
[INFO] [stdout] test sync::tests::sync_realpath_and_readlink ... ok
[INFO] [stdout] test protocol::tests::expect_readdir_rejects_ok_status_without_panic ... ok
[INFO] [stdout] test protocol::tests::parse_data_roundtrip ... ok
[INFO] [stdout] test sync::tests::sync_stat_returns_attributes ... ok
[INFO] [stdout] test sync::tests::sync_version_helper ... ok
[INFO] [stdout] test sync::tests::sync_status_mutators ... ok
[INFO] [stdout] test sync::tests::sync_pread_eof_surfaces ... ok
[INFO] [stdout] test sync::tests::sync_open_propagates_no_such_file ... ok
[INFO] [stdout] test protocol::tests::expect_name_rejects_ok_status_without_panic ... ok
[INFO] [stderr]      Running unittests src/bin/sftp.rs (/opt/rustwide/target/debug/deps/sftp-c0f2a6ce6ae08713)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 59 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sftp
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "8f807fb620f8ff32c56654a89d73ec73242f843093d1e3a746434fb199a9a297", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8f807fb620f8ff32c56654a89d73ec73242f843093d1e3a746434fb199a9a297", kill_on_drop: false }`
[INFO] [stdout] 8f807fb620f8ff32c56654a89d73ec73242f843093d1e3a746434fb199a9a297
