[INFO] fetching crate o-o 0.5.4... [INFO] testing o-o-0.5.4 against try#b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b for pr-145330-1 [INFO] extracting crate o-o 0.5.4 into /workspace/builds/worker-4-tc2/source [INFO] started tweaking crates.io crate o-o 0.5.4 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate o-o 0.5.4 [INFO] tweaked toml for crates.io crate o-o 0.5.4 written to /workspace/builds/worker-4-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate o-o 0.5.4 on toolchain b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate o-o 0.5.4 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" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 11b1e2f4d25dbb83e2fbc6b0c175be4a16cfc8b2992d9837f5cb7415a8fd04f5 [INFO] running `Command { std: "docker" "start" "-a" "11b1e2f4d25dbb83e2fbc6b0c175be4a16cfc8b2992d9837f5cb7415a8fd04f5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "11b1e2f4d25dbb83e2fbc6b0c175be4a16cfc8b2992d9837f5cb7415a8fd04f5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "11b1e2f4d25dbb83e2fbc6b0c175be4a16cfc8b2992d9837f5cb7415a8fd04f5", kill_on_drop: false }` [INFO] [stdout] 11b1e2f4d25dbb83e2fbc6b0c175be4a16cfc8b2992d9837f5cb7415a8fd04f5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 26103f17ea31cedcb1608534578761f3a342481a6c7128f6e0b5b43aab2790a2 [INFO] running `Command { std: "docker" "start" "-a" "26103f17ea31cedcb1608534578761f3a342481a6c7128f6e0b5b43aab2790a2", kill_on_drop: false }` [INFO] [stderr] Compiling anyhow v1.0.98 [INFO] [stderr] Compiling rustix v1.0.7 [INFO] [stderr] Compiling getrandom v0.3.3 [INFO] [stderr] Compiling linux-raw-sys v0.9.4 [INFO] [stderr] Compiling bitflags v2.9.1 [INFO] [stderr] Compiling fastrand v2.3.0 [INFO] [stderr] Compiling syn v2.0.101 [INFO] [stderr] Compiling os_pipe v1.2.1 [INFO] [stderr] Compiling shared_child v1.0.2 [INFO] [stderr] Compiling duct v0.13.7 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling tempfile v3.20.0 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling ng-clp v0.3.1 [INFO] [stderr] Compiling o-o v0.5.4 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.62s [INFO] running `Command { std: "docker" "inspect" "26103f17ea31cedcb1608534578761f3a342481a6c7128f6e0b5b43aab2790a2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "26103f17ea31cedcb1608534578761f3a342481a6c7128f6e0b5b43aab2790a2", kill_on_drop: false }` [INFO] [stdout] 26103f17ea31cedcb1608534578761f3a342481a6c7128f6e0b5b43aab2790a2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b9715a855864c71e859d3dc49a655c5c7e91a7a31fb8d0d21e0d54f89be19c07 [INFO] running `Command { std: "docker" "start" "-a" "b9715a855864c71e859d3dc49a655c5c7e91a7a31fb8d0d21e0d54f89be19c07", kill_on_drop: false }` [INFO] [stderr] Compiling o-o v0.5.4 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.86s [INFO] running `Command { std: "docker" "inspect" "b9715a855864c71e859d3dc49a655c5c7e91a7a31fb8d0d21e0d54f89be19c07", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b9715a855864c71e859d3dc49a655c5c7e91a7a31fb8d0d21e0d54f89be19c07", kill_on_drop: false }` [INFO] [stdout] b9715a855864c71e859d3dc49a655c5c7e91a7a31fb8d0d21e0d54f89be19c07 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8a44f9b40bfee7cd51d214d8e24e69365164f20dfbd30a0dbeab766d4d9549fc [INFO] running `Command { std: "docker" "start" "-a" "8a44f9b40bfee7cd51d214d8e24e69365164f20dfbd30a0dbeab766d4d9549fc", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/o_o-c0eabd1a73fa1203) [INFO] [stdout] running 0 tests [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/o_o-491fed1e2277cd6f) [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] [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] Running tests/executable-tests.rs (/opt/rustwide/target/debug/deps/executable_tests-e4cd961a05fcf3a9) [INFO] [stdout] [INFO] [stdout] running 17 tests [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o` [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.07s [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -d /tmp/.tmpmubwt2 - +/tmp/.tmpmubwt2/out.txt - echo '1st line'` [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.34s [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -d /tmp/.tmpeX1bTf - - - ls --a-option-ls-must-not-have` [INFO] [stdout] Run a sub-process and customize how it handles standard I/O. [INFO] [stdout] [INFO] [stdout] Usage: [INFO] [stdout] o-o [options] [--] ... [INFO] [stdout] o-o --help [INFO] [stdout] o-o --version [INFO] [stdout] [INFO] [stdout] Options: [INFO] [stdout] File served as the standard input. Use `-` for no redirection. [INFO] [stdout] File served as the standard output. Use `-` for no redirection, `=` for the same file as the standard input, and `.` for /dev/null. [INFO] [stdout] File served as the standard error. Use `-` for no redirection, `=` for the same file as the standard output, and `.` for /dev/null. [INFO] [stdout] Prefix with `+` to append to the file (akin to the `>>` redirection in shell). [INFO] [stdout] -e VAR=VALUE Set environment variables. [INFO] [stdout] --pipe=STR, -p STR String for pipe to connect subprocesses (`|` in shell) [default: `I`]. [INFO] [stdout] --separator=STR, -s STR String for separator of command lines (`;` in shell) [default: `J`]. [INFO] [stdout] --tempdir-placeholder=STR, -t STR Placeholder string for temporary directory [default: `T`]. [INFO] [stdout] --force-overwrite, -F Overwrite the file even if subprocess fails (exit status != 0). Valid only when is `=`. [INFO] [stdout] --keep-going, -k Only effective when multiple command lines are chained with the separator. Even if one command line fails, subsequent command lines continue to be executed. [INFO] [stdout] --working-directory=DIR, -d DIR Working directory. [INFO] [stdout] --version, -V Version information. [INFO] [stdout] --help, -h Shows this help message. [INFO] [stdout] test executable_tests::run_simple ... ok [INFO] [stderr] ls: unrecognized option '--a-option-ls-must-not-have' [INFO] [stderr] Try 'ls --help' for more information. [INFO] [stdout] test executable_tests::run_ls ... FAILED [INFO] [stdout] test executable_tests::run_ls_with_wrong_option ... ok [INFO] [stdout] test executable_tests::sub_oo_redirection ... FAILED [INFO] [stdout] test executable_tests::stdout_devnull ... ok [INFO] [stdout] test executable_tests::capture_stdout_and_stderr ... ok [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.16s [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -d /tmp/.tmpyJuUSo /tmp/.tmpyJuUSo/a.txt = - wc` [INFO] [stdout] test executable_tests::environment_variable ... ok [INFO] [stdout] test executable_tests::sequential_run_commands ... ok [INFO] [stdout] test executable_tests::overwrite_input_file ... ok [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stdout] test executable_tests::stderr_devnull ... ok [INFO] [stdout] test executable_tests::sink_to_stdin ... ok [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.30s [INFO] [stderr] Blocking waiting for file lock on build directory [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -F -d /tmp/.tmpJfwhlS /tmp/.tmpJfwhlS/a.txt = - bash /tmp/.tmpJfwhlS/echo_and_fail.sh` [INFO] [stdout] test executable_tests::sequential_run_commands_sub_oo_invalid_option ... ok [INFO] [stdout] test executable_tests::overwrite_with_process_which_fails ... ok [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.09s [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -d /tmp/.tmpMIct3W /tmp/.tmpMIct3W/a.txt = - bash /tmp/.tmpMIct3W/echo_and_fail.sh` [INFO] [stdout] test executable_tests::pipe_commands ... ok [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running `/opt/rustwide/target/debug/o-o -d /tmp/.tmpmubwt2 - +/tmp/.tmpmubwt2/out.txt - echo '2ne line'` [INFO] [stdout] test executable_tests::process_which_fails ... ok [INFO] [stdout] test executable_tests::append_to_output_file ... ok [INFO] [stdout] test executable_tests::redirect_stderr_to_stdout ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- executable_tests::run_ls stdout ---- [INFO] [stdout] Error: Os { code: 2, kind: NotFound, message: "No such file or directory" } [INFO] [stdout] [INFO] [stdout] ---- executable_tests::sub_oo_redirection stdout ---- [INFO] [stdout] Error: Os { code: 2, kind: NotFound, message: "No such file or directory" } [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] executable_tests::run_ls [INFO] [stdout] executable_tests::sub_oo_redirection [INFO] [stdout] [INFO] [stdout] test result: FAILED. 15 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.49s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test executable-tests` [INFO] running `Command { std: "docker" "inspect" "8a44f9b40bfee7cd51d214d8e24e69365164f20dfbd30a0dbeab766d4d9549fc", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8a44f9b40bfee7cd51d214d8e24e69365164f20dfbd30a0dbeab766d4d9549fc", kill_on_drop: false }` [INFO] [stdout] 8a44f9b40bfee7cd51d214d8e24e69365164f20dfbd30a0dbeab766d4d9549fc