Dec 15 18:18:52.110 INFO testing conch-runtime-0.1.5 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 18:18:52.110 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 18:18:52.687 INFO [stdout] 2abd36cf6cbc88514361fa2a7c7540da5f5a158eb48b6101dd086cafb0b2d13d Dec 15 18:18:52.695 INFO running `"docker" "start" "-a" "2abd36cf6cbc88514361fa2a7c7540da5f5a158eb48b6101dd086cafb0b2d13d"` Dec 15 18:18:53.931 INFO [stderr] usermod: no changes Dec 15 18:18:54.223 INFO [stderr] Compiling conch-parser v0.1.0 Dec 15 18:18:54.260 INFO [stderr] Compiling rental v0.4.16 Dec 15 18:18:54.271 INFO [stderr] Compiling tokio-signal v0.1.5 Dec 15 18:19:01.913 INFO [stderr] Compiling tokio-process v0.1.6 Dec 15 18:19:07.415 INFO [stderr] Compiling conch-runtime v0.1.5 (/source) Dec 15 18:19:12.979 INFO [stderr] warning: unused import: `VarRestorer` Dec 15 18:19:12.979 INFO [stderr] --> src/eval/redirect_or_var_assig.rs:3:67 Dec 15 18:19:12.979 INFO [stderr] | Dec 15 18:19:12.979 INFO [stderr] 3 | RedirectRestorer, VarEnvRestorer2, VariableEnvironment, VarRestorer}; Dec 15 18:19:12.979 INFO [stderr] | ^^^^^^^^^^^ Dec 15 18:19:12.979 INFO [stderr] | Dec 15 18:19:12.979 INFO [stderr] = note: #[warn(unused_imports)] on by default Dec 15 18:19:12.979 INFO [stderr] Dec 15 18:19:14.383 INFO [stderr] warning: use of deprecated item '>::backup': use the `RedirectEnvRestorer` trait instead Dec 15 18:19:14.383 INFO [stderr] --> src/env/reversible_redirect.rs:186:52 Dec 15 18:19:14.383 INFO [stderr] | Dec 15 18:19:14.383 INFO [stderr] 186 | RedirectAction::HereDoc(fd, _) => self.backup(fd, env), Dec 15 18:19:14.383 INFO [stderr] | ^^^^^^ Dec 15 18:19:14.383 INFO [stderr] | Dec 15 18:19:14.383 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 15 18:19:14.383 INFO [stderr] Dec 15 18:19:15.342 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:19:15.343 INFO [stderr] --> src/spawn/simple.rs:331:52 Dec 15 18:19:15.343 INFO [stderr] | Dec 15 18:19:15.343 INFO [stderr] 331 | red_restorer_inner.restore(env); Dec 15 18:19:15.343 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.343 INFO [stderr] Dec 15 18:19:15.350 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:19:15.350 INFO [stderr] --> src/spawn/simple.rs:358:47 Dec 15 18:19:15.350 INFO [stderr] | Dec 15 18:19:15.350 INFO [stderr] 358 | redirect_restorer.restore(env); Dec 15 18:19:15.350 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.354 INFO [stderr] Dec 15 18:19:15.354 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:19:15.355 INFO [stderr] --> src/spawn/simple.rs:359:42 Dec 15 18:19:15.355 INFO [stderr] | Dec 15 18:19:15.355 INFO [stderr] 359 | var_restorer.restore(env); Dec 15 18:19:15.355 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.355 INFO [stderr] Dec 15 18:19:15.358 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:19:15.358 INFO [stderr] --> src/spawn/simple.rs:387:27 Dec 15 18:19:15.359 INFO [stderr] | Dec 15 18:19:15.359 INFO [stderr] 387 | redirect_restorer.restore(env); Dec 15 18:19:15.359 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.359 INFO [stderr] Dec 15 18:19:15.374 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:19:15.375 INFO [stderr] --> src/spawn/simple.rs:397:22 Dec 15 18:19:15.375 INFO [stderr] | Dec 15 18:19:15.375 INFO [stderr] 397 | var_restorer.restore(env); Dec 15 18:19:15.375 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.375 INFO [stderr] Dec 15 18:19:15.398 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:19:15.399 INFO [stderr] --> src/spawn/simple.rs:415:35 Dec 15 18:19:15.399 INFO [stderr] | Dec 15 18:19:15.399 INFO [stderr] 415 | redirect_restorer.restore(env); Dec 15 18:19:15.399 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.399 INFO [stderr] Dec 15 18:19:15.399 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:19:15.399 INFO [stderr] --> src/spawn/simple.rs:416:30 Dec 15 18:19:15.399 INFO [stderr] | Dec 15 18:19:15.399 INFO [stderr] 416 | var_restorer.restore(env); Dec 15 18:19:15.399 INFO [stderr] | ^^^^^^^ Dec 15 18:19:15.399 INFO [stderr] Dec 15 18:19:44.082 INFO [stderr] warning: use of deprecated item 'sys::io::fd_ext::FileDescExt::into_evented': does not handle regular files, use `into_evented2` instead Dec 15 18:19:44.082 INFO [stderr] --> src/sys/unix/io/fd_ext.rs:73:14 Dec 15 18:19:44.082 INFO [stderr] | Dec 15 18:19:44.082 INFO [stderr] 73 | self.into_evented(handle).map(MaybeEventedFd::Registered) Dec 15 18:19:44.083 INFO [stderr] | ^^^^^^^^^^^^ Dec 15 18:19:44.083 INFO [stderr] Dec 15 18:19:44.138 INFO [stderr] warning: unused import: `VarEnvRestorer` Dec 15 18:19:44.138 INFO [stderr] --> src/spawn/simple.rs:5:36 Dec 15 18:19:44.138 INFO [stderr] | Dec 15 18:19:44.139 INFO [stderr] 5 | SetArgumentsEnvironment, VarEnvRestorer, VarEnvRestorer2, VarRestorer, Dec 15 18:19:44.139 INFO [stderr] | ^^^^^^^^^^^^^^ Dec 15 18:19:44.139 INFO [stderr] Dec 15 18:19:44.927 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:19:44.927 INFO [stderr] --> src/eval/redirect_or_cmd_word.rs:137:5 Dec 15 18:19:44.927 INFO [stderr] | Dec 15 18:19:44.927 INFO [stderr] 137 | mut restorer: RR, Dec 15 18:19:44.927 INFO [stderr] | ----^^^^^^^^ Dec 15 18:19:44.927 INFO [stderr] | | Dec 15 18:19:44.927 INFO [stderr] | help: remove this `mut` Dec 15 18:19:44.927 INFO [stderr] | Dec 15 18:19:44.927 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 18:19:44.927 INFO [stderr] Dec 15 18:19:44.955 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:19:44.955 INFO [stderr] --> src/eval/redirect_or_var_assig.rs:260:5 Dec 15 18:19:44.955 INFO [stderr] | Dec 15 18:19:44.955 INFO [stderr] 260 | mut redirect_restorer: RR, Dec 15 18:19:44.955 INFO [stderr] | ----^^^^^^^^^^^^^^^^^ Dec 15 18:19:44.955 INFO [stderr] | | Dec 15 18:19:44.955 INFO [stderr] | help: remove this `mut` Dec 15 18:19:44.955 INFO [stderr] Dec 15 18:19:45.351 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:19:45.351 INFO [stderr] --> src/spawn/simple.rs:386:13 Dec 15 18:19:45.351 INFO [stderr] | Dec 15 18:19:45.351 INFO [stderr] 386 | let mut redirect_restorer = redirect_restorer; Dec 15 18:19:45.351 INFO [stderr] | ----^^^^^^^^^^^^^^^^^ Dec 15 18:19:45.351 INFO [stderr] | | Dec 15 18:19:45.351 INFO [stderr] | help: remove this `mut` Dec 15 18:19:45.351 INFO [stderr] Dec 15 18:19:47.888 INFO [stderr] warning: method is never used: `set_cloexec` Dec 15 18:19:47.888 INFO [stderr] --> src/sys/unix/io/mod.rs:118:5 Dec 15 18:19:47.888 INFO [stderr] | Dec 15 18:19:47.888 INFO [stderr] 118 | pub fn set_cloexec(&self, set: bool) -> Result<()> { Dec 15 18:19:47.888 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 18:19:47.888 INFO [stderr] | Dec 15 18:19:47.888 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 15 18:19:47.888 INFO [stderr] Dec 15 18:19:54.278 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 00s Dec 15 18:19:54.295 INFO [stderr] su: No module specific data is present Dec 15 18:19:55.214 INFO running `"docker" "inspect" "2abd36cf6cbc88514361fa2a7c7540da5f5a158eb48b6101dd086cafb0b2d13d"` Dec 15 18:19:55.553 INFO running `"docker" "rm" "-f" "2abd36cf6cbc88514361fa2a7c7540da5f5a158eb48b6101dd086cafb0b2d13d"` Dec 15 18:19:55.874 INFO [stdout] 2abd36cf6cbc88514361fa2a7c7540da5f5a158eb48b6101dd086cafb0b2d13d Dec 15 18:19:55.877 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 18:19:56.439 INFO [stdout] bc1fcc251a33e6be6b3665f688c4a0b5b746cb4decf5ae177a11c372a8ea7261 Dec 15 18:19:56.443 INFO running `"docker" "start" "-a" "bc1fcc251a33e6be6b3665f688c4a0b5b746cb4decf5ae177a11c372a8ea7261"` Dec 15 18:19:58.104 INFO [stderr] usermod: no changes Dec 15 18:19:58.382 INFO [stderr] Compiling owned_chars v0.2.1 Dec 15 18:19:59.249 INFO [stderr] Compiling conch-runtime v0.1.5 (/source) Dec 15 18:20:35.431 INFO [stderr] warning: unused import: `VarRestorer` Dec 15 18:20:35.431 INFO [stderr] --> src/eval/redirect_or_var_assig.rs:3:67 Dec 15 18:20:35.431 INFO [stderr] | Dec 15 18:20:35.431 INFO [stderr] 3 | RedirectRestorer, VarEnvRestorer2, VariableEnvironment, VarRestorer}; Dec 15 18:20:35.431 INFO [stderr] | ^^^^^^^^^^^ Dec 15 18:20:35.431 INFO [stderr] | Dec 15 18:20:35.431 INFO [stderr] = note: #[warn(unused_imports)] on by default Dec 15 18:20:35.431 INFO [stderr] Dec 15 18:20:48.599 INFO [stderr] warning: use of deprecated item '>::backup': use the `RedirectEnvRestorer` trait instead Dec 15 18:20:48.599 INFO [stderr] --> src/env/reversible_redirect.rs:186:52 Dec 15 18:20:48.599 INFO [stderr] | Dec 15 18:20:48.599 INFO [stderr] 186 | RedirectAction::HereDoc(fd, _) => self.backup(fd, env), Dec 15 18:20:48.599 INFO [stderr] | ^^^^^^ Dec 15 18:20:48.599 INFO [stderr] | Dec 15 18:20:48.599 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 15 18:20:48.599 INFO [stderr] Dec 15 18:20:56.203 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:20:56.203 INFO [stderr] --> src/spawn/simple.rs:331:52 Dec 15 18:20:56.203 INFO [stderr] | Dec 15 18:20:56.203 INFO [stderr] 331 | red_restorer_inner.restore(env); Dec 15 18:20:56.203 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.203 INFO [stderr] Dec 15 18:20:56.231 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:20:56.231 INFO [stderr] --> src/spawn/simple.rs:358:47 Dec 15 18:20:56.231 INFO [stderr] | Dec 15 18:20:56.231 INFO [stderr] 358 | redirect_restorer.restore(env); Dec 15 18:20:56.231 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.231 INFO [stderr] Dec 15 18:20:56.231 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:20:56.231 INFO [stderr] --> src/spawn/simple.rs:359:42 Dec 15 18:20:56.231 INFO [stderr] | Dec 15 18:20:56.231 INFO [stderr] 359 | var_restorer.restore(env); Dec 15 18:20:56.231 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.231 INFO [stderr] Dec 15 18:20:56.255 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:20:56.255 INFO [stderr] --> src/spawn/simple.rs:387:27 Dec 15 18:20:56.255 INFO [stderr] | Dec 15 18:20:56.255 INFO [stderr] 387 | redirect_restorer.restore(env); Dec 15 18:20:56.255 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.255 INFO [stderr] Dec 15 18:20:56.288 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:20:56.288 INFO [stderr] --> src/spawn/simple.rs:397:22 Dec 15 18:20:56.288 INFO [stderr] | Dec 15 18:20:56.288 INFO [stderr] 397 | var_restorer.restore(env); Dec 15 18:20:56.288 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.288 INFO [stderr] Dec 15 18:20:56.375 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:20:56.375 INFO [stderr] --> src/spawn/simple.rs:415:35 Dec 15 18:20:56.375 INFO [stderr] | Dec 15 18:20:56.375 INFO [stderr] 415 | redirect_restorer.restore(env); Dec 15 18:20:56.375 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.375 INFO [stderr] Dec 15 18:20:56.375 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:20:56.375 INFO [stderr] --> src/spawn/simple.rs:416:30 Dec 15 18:20:56.375 INFO [stderr] | Dec 15 18:20:56.375 INFO [stderr] 416 | var_restorer.restore(env); Dec 15 18:20:56.375 INFO [stderr] | ^^^^^^^ Dec 15 18:20:56.375 INFO [stderr] Dec 15 18:23:11.359 INFO [stderr] warning: use of deprecated item 'sys::io::fd_ext::FileDescExt::into_evented': does not handle regular files, use `into_evented2` instead Dec 15 18:23:11.359 INFO [stderr] --> src/sys/unix/io/fd_ext.rs:73:14 Dec 15 18:23:11.359 INFO [stderr] | Dec 15 18:23:11.359 INFO [stderr] 73 | self.into_evented(handle).map(MaybeEventedFd::Registered) Dec 15 18:23:11.359 INFO [stderr] | ^^^^^^^^^^^^ Dec 15 18:23:11.359 INFO [stderr] Dec 15 18:23:11.639 INFO [stderr] warning: unused import: `VarEnvRestorer` Dec 15 18:23:11.639 INFO [stderr] --> src/spawn/simple.rs:5:36 Dec 15 18:23:11.639 INFO [stderr] | Dec 15 18:23:11.639 INFO [stderr] 5 | SetArgumentsEnvironment, VarEnvRestorer, VarEnvRestorer2, VarRestorer, Dec 15 18:23:11.639 INFO [stderr] | ^^^^^^^^^^^^^^ Dec 15 18:23:11.639 INFO [stderr] Dec 15 18:23:16.703 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:23:16.703 INFO [stderr] --> tests/redirect_or_var_assig.rs:101:23 Dec 15 18:23:16.703 INFO [stderr] | Dec 15 18:23:16.703 INFO [stderr] 101 | redirect_restorer.restore(&mut env); Dec 15 18:23:16.703 INFO [stderr] | ^^^^^^^ Dec 15 18:23:16.731 INFO [stderr] | Dec 15 18:23:16.731 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 15 18:23:16.731 INFO [stderr] Dec 15 18:23:16.767 INFO [stderr] warning: use of deprecated item '>::restore': use the `VarEnvRestorer` trait instead Dec 15 18:23:16.767 INFO [stderr] --> tests/redirect_or_var_assig.rs:109:18 Dec 15 18:23:16.767 INFO [stderr] | Dec 15 18:23:16.767 INFO [stderr] 109 | var_restorer.restore(&mut env); Dec 15 18:23:16.767 INFO [stderr] | ^^^^^^^ Dec 15 18:23:16.795 INFO [stderr] Dec 15 18:23:17.559 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:23:17.559 INFO [stderr] --> src/eval/redirect_or_cmd_word.rs:137:5 Dec 15 18:23:17.559 INFO [stderr] | Dec 15 18:23:17.559 INFO [stderr] 137 | mut restorer: RR, Dec 15 18:23:17.559 INFO [stderr] | ----^^^^^^^^ Dec 15 18:23:17.559 INFO [stderr] | | Dec 15 18:23:17.559 INFO [stderr] | help: remove this `mut` Dec 15 18:23:17.559 INFO [stderr] | Dec 15 18:23:17.559 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 18:23:17.559 INFO [stderr] Dec 15 18:23:17.619 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:23:17.619 INFO [stderr] --> src/eval/redirect_or_var_assig.rs:260:5 Dec 15 18:23:17.619 INFO [stderr] | Dec 15 18:23:17.619 INFO [stderr] 260 | mut redirect_restorer: RR, Dec 15 18:23:17.619 INFO [stderr] | ----^^^^^^^^^^^^^^^^^ Dec 15 18:23:17.619 INFO [stderr] | | Dec 15 18:23:17.619 INFO [stderr] | help: remove this `mut` Dec 15 18:23:17.619 INFO [stderr] Dec 15 18:23:18.419 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:23:18.419 INFO [stderr] --> tests/redirect_or_var_assig.rs:97:33 Dec 15 18:23:18.419 INFO [stderr] | Dec 15 18:23:18.419 INFO [stderr] 97 | let (mut redirect_restorer, mut var_restorer) = lp.run(poll_fn(|| future.poll(&mut env))) Dec 15 18:23:18.419 INFO [stderr] | ----^^^^^^^^^^^^ Dec 15 18:23:18.419 INFO [stderr] | | Dec 15 18:23:18.419 INFO [stderr] | help: remove this `mut` Dec 15 18:23:18.419 INFO [stderr] | Dec 15 18:23:18.419 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 18:23:18.419 INFO [stderr] Dec 15 18:23:18.419 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:23:18.419 INFO [stderr] --> tests/redirect_or_var_assig.rs:97:10 Dec 15 18:23:18.419 INFO [stderr] | Dec 15 18:23:18.419 INFO [stderr] 97 | let (mut redirect_restorer, mut var_restorer) = lp.run(poll_fn(|| future.poll(&mut env))) Dec 15 18:23:18.419 INFO [stderr] | ----^^^^^^^^^^^^^^^^^ Dec 15 18:23:18.419 INFO [stderr] | | Dec 15 18:23:18.419 INFO [stderr] | help: remove this `mut` Dec 15 18:23:18.419 INFO [stderr] Dec 15 18:23:18.527 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:23:18.527 INFO [stderr] --> src/spawn/simple.rs:386:13 Dec 15 18:23:18.527 INFO [stderr] | Dec 15 18:23:18.527 INFO [stderr] 386 | let mut redirect_restorer = redirect_restorer; Dec 15 18:23:18.527 INFO [stderr] | ----^^^^^^^^^^^^^^^^^ Dec 15 18:23:18.527 INFO [stderr] | | Dec 15 18:23:18.527 INFO [stderr] | help: remove this `mut` Dec 15 18:23:18.527 INFO [stderr] Dec 15 18:23:25.680 INFO [stderr] warning: method is never used: `set_cloexec` Dec 15 18:23:25.680 INFO [stderr] --> src/sys/unix/io/mod.rs:118:5 Dec 15 18:23:25.680 INFO [stderr] | Dec 15 18:23:25.680 INFO [stderr] 118 | pub fn set_cloexec(&self, set: bool) -> Result<()> { Dec 15 18:23:25.680 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 18:23:25.680 INFO [stderr] | Dec 15 18:23:25.680 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 15 18:23:25.680 INFO [stderr] Dec 15 18:24:10.475 INFO [stderr] warning: use of deprecated item '>::restore': use the `RedirectEnvRestorer` trait instead Dec 15 18:24:10.475 INFO [stderr] --> tests/redirect_or_cmd_word.rs:45:14 Dec 15 18:24:10.475 INFO [stderr] | Dec 15 18:24:10.475 INFO [stderr] 45 | restorer.restore(&mut env); Dec 15 18:24:10.475 INFO [stderr] | ^^^^^^^ Dec 15 18:24:10.475 INFO [stderr] | Dec 15 18:24:10.475 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 15 18:24:10.475 INFO [stderr] Dec 15 18:24:11.943 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:24:11.943 INFO [stderr] --> tests/redirect_or_cmd_word.rs:42:10 Dec 15 18:24:11.943 INFO [stderr] | Dec 15 18:24:11.943 INFO [stderr] 42 | let (mut restorer, words) = lp.run(poll_fn(|| future.poll(&mut env))).unwrap(); Dec 15 18:24:11.943 INFO [stderr] | ----^^^^^^^^ Dec 15 18:24:11.943 INFO [stderr] | | Dec 15 18:24:11.943 INFO [stderr] | help: remove this `mut` Dec 15 18:24:11.943 INFO [stderr] | Dec 15 18:24:11.943 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 18:24:11.943 INFO [stderr] Dec 15 18:24:14.359 INFO [stderr] warning: variable does not need to be mutable Dec 15 18:24:14.359 INFO [stderr] --> tests/redirect_or_var_assig_deprecated.rs:52:10 Dec 15 18:24:14.359 INFO [stderr] | Dec 15 18:24:14.359 INFO [stderr] 52 | let (mut restorer, vars) = lp.run(poll_fn(|| future.poll(&mut env))).unwrap(); Dec 15 18:24:14.359 INFO [stderr] | ----^^^^^^^^ Dec 15 18:24:14.359 INFO [stderr] | | Dec 15 18:24:14.359 INFO [stderr] | help: remove this `mut` Dec 15 18:24:14.359 INFO [stderr] | Dec 15 18:24:14.359 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 18:24:14.359 INFO [stderr] Dec 15 18:27:17.079 INFO [stderr] warning: unused import: `std::marker::PhantomData` Dec 15 18:27:17.079 INFO [stderr] --> tests/simple.rs:13:5 Dec 15 18:27:17.079 INFO [stderr] | Dec 15 18:27:17.079 INFO [stderr] 13 | use std::marker::PhantomData; Dec 15 18:27:17.079 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 18:27:17.079 INFO [stderr] | Dec 15 18:27:17.079 INFO [stderr] = note: #[warn(unused_imports)] on by default Dec 15 18:27:17.079 INFO [stderr] Dec 15 18:27:30.840 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7m 32s Dec 15 18:27:30.935 INFO [stderr] su: No module specific data is present Dec 15 18:27:31.320 INFO running `"docker" "inspect" "bc1fcc251a33e6be6b3665f688c4a0b5b746cb4decf5ae177a11c372a8ea7261"` Dec 15 18:27:31.520 INFO running `"docker" "rm" "-f" "bc1fcc251a33e6be6b3665f688c4a0b5b746cb4decf5ae177a11c372a8ea7261"` Dec 15 18:27:31.646 INFO [stdout] bc1fcc251a33e6be6b3665f688c4a0b5b746cb4decf5ae177a11c372a8ea7261 Dec 15 18:27:31.647 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 18:27:31.891 INFO [stdout] b8aba223c4ed1a1aaa942e6b04c2c8cdaeccbcf5ad6a47f47e9e54de974fd2b6 Dec 15 18:27:31.892 INFO running `"docker" "start" "-a" "b8aba223c4ed1a1aaa942e6b04c2c8cdaeccbcf5ad6a47f47e9e54de974fd2b6"` Dec 15 18:27:32.307 INFO [stderr] usermod: no changes Dec 15 18:27:32.579 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.25s Dec 15 18:27:32.634 INFO [stderr] Running /target/debug/deps/conch_runtime-f7426624ebb079d4 Dec 15 18:27:32.640 INFO [stdout] Dec 15 18:27:32.640 INFO [stdout] running 24 tests Dec 15 18:27:32.641 INFO [stdout] test env::args::tests::test_set_args ... ok Dec 15 18:27:32.641 INFO [stdout] test env::args::tests::test_name ... ok Dec 15 18:27:32.641 INFO [stdout] test env::args::tests::test_sub_env_no_needless_clone ... ok Dec 15 18:27:32.641 INFO [stdout] test env::fd::tests::test_set_get_and_close_file_desc ... ok Dec 15 18:27:32.641 INFO [stdout] test env::args::tests::test_args ... ok Dec 15 18:27:32.641 INFO [stdout] test env::args::tests::test_shift_args ... ok Dec 15 18:27:32.641 INFO [stdout] test env::fd::tests::test_set_and_closefile_desc_in_child_env_should_not_affect_parent ... ok Dec 15 18:27:32.643 INFO [stdout] test env::fd::tests::test_sub_env_no_needless_clone ... ok Dec 15 18:27:32.643 INFO [stdout] test env::last_status::tests::test_set_last_status_in_child_env_should_not_affect_parent ... ok Dec 15 18:27:32.643 INFO [stdout] test env::func::tests::test_set_and_unset_function_in_child_should_not_affect_parent ... ok Dec 15 18:27:32.643 INFO [stdout] test env::var::tests::test_env_vars ... ok Dec 15 18:27:32.644 INFO [stdout] test env::env_impl::tests::test_env_is_interactive ... ok Dec 15 18:27:32.644 INFO [stdout] test env::func::tests::test_set_function_in_parent_visible_in_child ... ok Dec 15 18:27:32.645 INFO [stdout] test env::func::tests::test_set_get_unset_function ... ok Dec 15 18:27:32.645 INFO [stdout] test env::var::tests::test_set_get_unset_var ... ok Dec 15 18:27:32.645 INFO [stdout] test env::func::tests::test_sub_env_no_needless_clone ... ok Dec 15 18:27:32.645 INFO [stdout] test env::last_status::tests::test_env_set_and_get_last_status ... ok Dec 15 18:27:32.645 INFO [stdout] test env::var::tests::test_sub_env_no_needless_clone ... ok Dec 15 18:27:32.645 INFO [stdout] test error::tests::ensure_runtime_errors_are_send_and_sync ... ok Dec 15 18:27:32.645 INFO [stdout] test env::var::tests::test_set_var_in_child_env_should_not_affect_parent ... ok Dec 15 18:27:32.645 INFO [stdout] test io::pipe::tests::smoke ... ok Dec 15 18:27:32.645 INFO [stdout] test io::tests::ensure_file_desc_is_send_and_sync ... ok Dec 15 18:27:32.647 INFO [stdout] test env::var::tests::test_get_env_vars_visible_in_parent_and_child ... ok Dec 15 18:27:32.647 INFO [stdout] test env::var::tests::test_set_get_unset_exported_var ... ok Dec 15 18:27:32.647 INFO [stdout] Dec 15 18:27:32.647 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.647 INFO [stdout] Dec 15 18:27:32.648 INFO [stderr] Running /target/debug/deps/cat_dup-38d7fb2612ca0e95 Dec 15 18:27:32.653 INFO [stdout] Dec 15 18:27:32.653 INFO [stdout] running 0 tests Dec 15 18:27:32.653 INFO [stdout] Dec 15 18:27:32.653 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.653 INFO [stdout] Dec 15 18:27:32.654 INFO [stderr] Running /target/debug/deps/env-089497cce7553347 Dec 15 18:27:32.657 INFO [stdout] Dec 15 18:27:32.657 INFO [stdout] running 0 tests Dec 15 18:27:32.657 INFO [stdout] Dec 15 18:27:32.657 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.657 INFO [stdout] Dec 15 18:27:32.657 INFO [stderr] Running /target/debug/deps/pwd-89dc3d00d8563e2d Dec 15 18:27:32.661 INFO [stdout] Dec 15 18:27:32.661 INFO [stdout] running 0 tests Dec 15 18:27:32.661 INFO [stdout] Dec 15 18:27:32.661 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.661 INFO [stdout] Dec 15 18:27:32.661 INFO [stderr] Running /target/debug/deps/and_or-1a4888e6b2ef9043 Dec 15 18:27:32.663 INFO [stdout] Dec 15 18:27:32.663 INFO [stdout] running 8 tests Dec 15 18:27:32.721 INFO [stdout] test test_and_or_should_propagate_cancel_to_current_command ... ok Dec 15 18:27:32.723 INFO [stdout] test test_and_or_should_run_or_if_last_status_was_unsuccessful ... ok Dec 15 18:27:32.730 INFO [stdout] test test_and_or_should_skip_and_if_last_status_was_unsuccessful ... ok Dec 15 18:27:32.732 INFO [stderr] and_or-1a4888e6b2ef9043: mock fatal error Dec 15 18:27:32.732 INFO [stderr] and_or-1a4888e6b2ef9043: mock fatal error Dec 15 18:27:32.779 INFO [stdout] test test_and_or_should_run_and_if_last_status_was_successful ... ok Dec 15 18:27:32.779 INFO [stdout] test test_and_or_should_propagate_fatal_errors ... ok Dec 15 18:27:32.779 INFO [stdout] test test_and_or_single_command ... ok Dec 15 18:27:32.782 INFO [stdout] test test_and_or_should_skip_or_if_last_status_was_successful ... ok Dec 15 18:27:32.782 INFO [stderr] and_or-1a4888e6b2ef9043: mock fatal error Dec 15 18:27:32.782 INFO [stderr] and_or-1a4888e6b2ef9043: mock fatal error Dec 15 18:27:32.782 INFO [stdout] test test_and_or_should_swallow_non_fatal_errors ... ok Dec 15 18:27:32.782 INFO [stdout] Dec 15 18:27:32.782 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.782 INFO [stdout] Dec 15 18:27:32.792 INFO [stderr] Running /target/debug/deps/arith-38f56f7fd01e3e79 Dec 15 18:27:32.800 INFO [stdout] Dec 15 18:27:32.800 INFO [stdout] running 1 test Dec 15 18:27:32.804 INFO [stdout] test test_eval_arith ... ok Dec 15 18:27:32.804 INFO [stdout] Dec 15 18:27:32.804 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.804 INFO [stdout] Dec 15 18:27:32.804 INFO [stderr] Running /target/debug/deps/async_io-d85f8e02121bc3e5 Dec 15 18:27:32.828 INFO [stdout] Dec 15 18:27:32.828 INFO [stdout] running 2 tests Dec 15 18:27:32.841 INFO [stdout] test async_io_thread_pool_smoke ... ok Dec 15 18:27:32.841 INFO [stdout] test evented_io_env_smoke ... ok Dec 15 18:27:32.841 INFO [stdout] Dec 15 18:27:32.842 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:32.842 INFO [stdout] Dec 15 18:27:32.842 INFO [stderr] Running /target/debug/deps/case-83b5c0066d89402f Dec 15 18:27:32.883 INFO [stdout] Dec 15 18:27:32.883 INFO [stdout] running 7 tests Dec 15 18:27:32.963 INFO [stdout] test should_match_patterns_case_sensitively ... ok Dec 15 18:27:32.963 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:32.963 INFO [stdout] test should_only_run_one_arm_body_if_a_pattern_matches_lazily ... ok Dec 15 18:27:32.963 INFO [stderr] case-83b5c0066d89402f: mock fatal error Dec 15 18:27:32.975 INFO [stdout] test should_expand_only_first_word_tilde_without_further_field_splitting ... ok Dec 15 18:27:33.020 INFO [stdout] test should_return_success_if_no_arms_or_no_matches ... ok Dec 15 18:27:33.023 INFO [stdout] test should_join_word_with_space_if_it_evals_with_multiple_fields ... ok Dec 15 18:27:33.027 INFO [stdout] test should_propagate_fatal_errors ... ok Dec 15 18:27:33.027 INFO [stdout] Dec 15 18:27:33.027 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:33.027 INFO [stdout] Dec 15 18:27:33.031 INFO [stderr] Running /target/debug/deps/cd-99bf218b2fc8f510 Dec 15 18:27:33.055 INFO [stdout] Dec 15 18:27:33.055 INFO [stdout] running 12 tests Dec 15 18:27:33.219 INFO [stdout] test dash_unset_old_pwd_is_error ... ok Dec 15 18:27:33.250 INFO [stdout] test dash_arg_uses_oldpwd_var ... ok Dec 15 18:27:33.250 INFO [stdout] test logical_relative ... ok Dec 15 18:27:33.252 INFO [stdout] test logical_absolute ... ok Dec 15 18:27:33.253 INFO [stdout] test no_arg_uses_home_var ... ok Dec 15 18:27:33.253 INFO [stdout] test no_arg_unset_home_is_error ... ok Dec 15 18:27:33.271 INFO [stdout] test physical_absolute ... ok Dec 15 18:27:33.271 INFO [stdout] test nulls_in_cdargs_treated_as_current_directory ... ok Dec 15 18:27:33.275 INFO [stdout] test successful_if_no_stdout ... ok Dec 15 18:27:33.287 INFO [stdout] test physical_relative ... ok Dec 15 18:27:33.287 INFO [stdout] test uses_cdargs_appropriately_if_defined ... ok Dec 15 18:27:33.527 INFO [stdout] test polling_canceled_pwd_panics ... ok Dec 15 18:27:33.527 INFO [stdout] Dec 15 18:27:33.527 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:33.527 INFO [stdout] Dec 15 18:27:33.534 INFO [stderr] Running /target/debug/deps/colon-e7884c4f399ef8d2 Dec 15 18:27:33.547 INFO [stderr] Running /target/debug/deps/command-34df3bf5b4b4b2b6 Dec 15 18:27:33.547 INFO [stdout] Dec 15 18:27:33.547 INFO [stdout] running 1 test Dec 15 18:27:33.547 INFO [stdout] test colon_smoke ... ok Dec 15 18:27:33.547 INFO [stdout] Dec 15 18:27:33.547 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:33.547 INFO [stdout] Dec 15 18:27:33.554 INFO [stdout] Dec 15 18:27:33.555 INFO [stdout] running 4 tests Dec 15 18:27:33.626 INFO [stdout] test test_job ... ok Dec 15 18:27:33.634 INFO [stdout] test test_propagates_all_errors ... ok Dec 15 18:27:33.635 INFO [stdout] test test_list ... ok Dec 15 18:27:33.635 INFO [stdout] test test_propagates_cancellations ... ok Dec 15 18:27:33.635 INFO [stdout] Dec 15 18:27:33.635 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:33.635 INFO [stdout] Dec 15 18:27:33.639 INFO [stderr] Running /target/debug/deps/complex_word-4f0715c4ccb688fb Dec 15 18:27:33.648 INFO [stdout] Dec 15 18:27:33.648 INFO [stdout] running 10 tests Dec 15 18:27:33.671 INFO [stdout] test test_concat_cancel ... ok Dec 15 18:27:33.743 INFO [stdout] test test_concat_expands_to_many_fields_and_joins_with_those_before_and_after ... ok Dec 15 18:27:33.743 INFO [stdout] test test_concat_should_not_expand_tilde_which_is_not_at_start ... ok Dec 15 18:27:33.755 INFO [stdout] test test_single_cancel ... ok Dec 15 18:27:33.791 INFO [stdout] test test_concat_param_at_expands_to_nothing_when_args_not_set_and_concats_with_rest ... ok Dec 15 18:27:33.791 INFO [stdout] test test_concat_param_at_expands_when_args_set_and_concats_with_rest ... ok Dec 15 18:27:33.811 INFO [stdout] test test_concat_error ... ok Dec 15 18:27:33.831 INFO [stdout] test test_concat_joins_all_inner_words ... ok Dec 15 18:27:33.831 INFO [stdout] test test_concat_empty_words_results_in_zero_field ... ok Dec 15 18:27:33.831 INFO [stdout] test test_single ... ok Dec 15 18:27:33.831 INFO [stdout] Dec 15 18:27:33.831 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:33.831 INFO [stdout] Dec 15 18:27:33.836 INFO [stderr] Running /target/debug/deps/compound-525e8c3dc9337005 Dec 15 18:27:33.841 INFO [stdout] Dec 15 18:27:33.841 INFO [stdout] running 2 tests Dec 15 18:27:33.963 INFO [stdout] test compound_command_kind_smoke ... ok Dec 15 18:27:34.003 INFO [stdout] test compound_command_kind_cancel_smoke ... ok Dec 15 18:27:34.003 INFO [stdout] Dec 15 18:27:34.003 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.003 INFO [stdout] Dec 15 18:27:34.008 INFO [stderr] Running /target/debug/deps/cur_dir-953c4f65a77759e6 Dec 15 18:27:34.022 INFO [stderr] Running /target/debug/deps/echo-277dfc57dd8811fe Dec 15 18:27:34.022 INFO [stdout] Dec 15 18:27:34.022 INFO [stdout] running 5 tests Dec 15 18:27:34.022 INFO [stdout] test cur_dir_should_not_change_absolute_paths ... ok Dec 15 18:27:34.022 INFO [stdout] test cur_dir_should_prefix_relative_paths_with_cwd ... ok Dec 15 18:27:34.022 INFO [stdout] test change_cur_dir_should_accept_relative_paths ... ok Dec 15 18:27:34.022 INFO [stdout] test get_cur_dir ... ok Dec 15 18:27:34.023 INFO [stdout] test change_cur_dir_should_accept_absolute_paths ... ok Dec 15 18:27:34.023 INFO [stdout] Dec 15 18:27:34.023 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.023 INFO [stdout] Dec 15 18:27:34.055 INFO [stdout] Dec 15 18:27:34.055 INFO [stdout] running 9 tests Dec 15 18:27:34.083 INFO [stdout] test double_dash_is_always_a_literal ... ok Dec 15 18:27:34.142 INFO [stdout] test incomplete_or_unreconigzed_escapes_treated_as_literals ... ok Dec 15 18:27:34.159 INFO [stdout] test escape_flag_turns_on_escape_interpretation ... ok Dec 15 18:27:34.162 INFO [stdout] test flags_can_have_varying_formats_at_start_of_args ... ok Dec 15 18:27:34.175 INFO [stdout] test flags_not_at_start_of_args_are_literals ... ok Dec 15 18:27:34.182 INFO [stdout] test suppress_newline ... ok Dec 15 18:27:34.186 INFO [stdout] test no_escape_flag_turns_off_escape_interpretation ... ok Dec 15 18:27:34.186 INFO [stdout] test flag_option_with_unrecognized_flag_becomes_literal ... ok Dec 15 18:27:34.189 INFO [stdout] test smoke ... ok Dec 15 18:27:34.189 INFO [stdout] Dec 15 18:27:34.189 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.189 INFO [stdout] Dec 15 18:27:34.199 INFO [stderr] Running /target/debug/deps/evented_fd-6f184e0a3871469e Dec 15 18:27:34.219 INFO [stdout] Dec 15 18:27:34.219 INFO [stdout] running 2 tests Dec 15 18:27:34.268 INFO [stdout] test evented_supports_regular_files ... ok Dec 15 18:27:34.385 INFO [stdout] test evented_is_async ... ok Dec 15 18:27:34.385 INFO [stdout] Dec 15 18:27:34.385 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.385 INFO [stdout] Dec 15 18:27:34.387 INFO [stderr] Running /target/debug/deps/executable-0ba3364aa01311ba Dec 15 18:27:34.398 INFO [stdout] Dec 15 18:27:34.399 INFO [stdout] running 4 tests Dec 15 18:27:34.446 INFO [stdout] test env_vars_set_from_data_without_inheriting_from_process ... ok Dec 15 18:27:34.451 INFO [stdout] test defines_empty_path_env_var_if_not_provided_by_caller ... ok Dec 15 18:27:34.462 INFO [stdout] test remote_spawn_smoke ... ok Dec 15 18:27:34.470 INFO [stdout] test spawn_executable_with_io ... ok Dec 15 18:27:34.471 INFO [stdout] Dec 15 18:27:34.471 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.471 INFO [stdout] Dec 15 18:27:34.472 INFO [stderr] Running /target/debug/deps/exit_status-766e505592e46965 Dec 15 18:27:34.477 INFO [stdout] Dec 15 18:27:34.477 INFO [stdout] running 2 tests Dec 15 18:27:34.483 INFO [stdout] test smoke_env_future ... ok Dec 15 18:27:34.483 INFO [stderr] Running /target/debug/deps/false_cmd-245ffa7ac2ab8fcb Dec 15 18:27:34.483 INFO [stdout] test smoke_future ... ok Dec 15 18:27:34.483 INFO [stdout] Dec 15 18:27:34.483 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.483 INFO [stdout] Dec 15 18:27:34.519 INFO [stdout] Dec 15 18:27:34.519 INFO [stdout] running 1 test Dec 15 18:27:34.523 INFO [stdout] test false_smoke ... ok Dec 15 18:27:34.523 INFO [stdout] Dec 15 18:27:34.523 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.523 INFO [stdout] Dec 15 18:27:34.528 INFO [stderr] Running /target/debug/deps/fields-c88a7cf6ed918d72 Dec 15 18:27:34.541 INFO [stdout] Dec 15 18:27:34.541 INFO [stdout] running 9 tests Dec 15 18:27:34.541 INFO [stdout] test test_fields_from_t ... ok Dec 15 18:27:34.541 INFO [stdout] test test_eval_parameter_substitution_splitting_default_ifs ... ok Dec 15 18:27:34.541 INFO [stdout] test test_splitting_with_custom_ifs ... ok Dec 15 18:27:34.541 INFO [stdout] test test_no_splitting_if_ifs_blank ... ok Dec 15 18:27:34.542 INFO [stdout] test test_fields_from_vec ... ok Dec 15 18:27:34.542 INFO [stdout] test test_fields_join_with_ifs ... ok Dec 15 18:27:34.546 INFO [stdout] test test_fields_join ... ok Dec 15 18:27:34.546 INFO [stderr] Running /target/debug/deps/file_desc-0b8fd2286b7b0db8 Dec 15 18:27:34.546 INFO [stdout] test test_fields_is_null ... ok Dec 15 18:27:34.546 INFO [stdout] test test_fields_into_iter ... ok Dec 15 18:27:34.546 INFO [stdout] Dec 15 18:27:34.546 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.546 INFO [stdout] Dec 15 18:27:34.554 INFO [stdout] Dec 15 18:27:34.554 INFO [stdout] running 2 tests Dec 15 18:27:34.571 INFO [stdout] test test_file_desc_seeking ... ok Dec 15 18:27:34.571 INFO [stderr] Running /target/debug/deps/for_cmd-48df0b8e6fdefbf1 Dec 15 18:27:34.571 INFO [stdout] test test_file_desc_duplicate ... ok Dec 15 18:27:34.571 INFO [stdout] Dec 15 18:27:34.571 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.571 INFO [stdout] Dec 15 18:27:34.599 INFO [stdout] Dec 15 18:27:34.599 INFO [stdout] running 6 tests Dec 15 18:27:34.603 INFO [stdout] test should_run_with_appropriate_args ... ok Dec 15 18:27:34.643 INFO [stdout] test should_propagate_all_word_errors ... ok Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.643 INFO [stderr] for_cmd-48df0b8e6fdefbf1: mock fatal error Dec 15 18:27:34.652 INFO [stdout] test should_swallow_non_fatal_errors_in_body ... ok Dec 15 18:27:34.652 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:34.657 INFO [stdout] test should_not_run_body_args_are_empty ... ok Dec 15 18:27:34.657 INFO [stderr] Running /target/debug/deps/func_exec-95cf7ece246b45b5 Dec 15 18:27:34.657 INFO [stdout] test should_propagate_fatal_errors_in_body ... ok Dec 15 18:27:34.657 INFO [stdout] Dec 15 18:27:34.657 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.657 INFO [stdout] Dec 15 18:27:34.666 INFO [stdout] Dec 15 18:27:34.667 INFO [stdout] running 4 tests Dec 15 18:27:34.743 INFO [stdout] test should_restore_args_after_completion ... ok Dec 15 18:27:34.751 INFO [stdout] test should_propagate_cancel_and_restore_args ... ok Dec 15 18:27:34.751 INFO [stdout] test test_env_run_function_nested_calls_do_not_destroy_upper_args ... ok Dec 15 18:27:34.751 INFO [stdout] test should_propagate_errors_and_restore_args ... ok Dec 15 18:27:34.751 INFO [stdout] Dec 15 18:27:34.751 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.751 INFO [stdout] Dec 15 18:27:34.762 INFO [stderr] Running /target/debug/deps/fuse-968abe0c4e7582cb Dec 15 18:27:34.763 INFO [stdout] Dec 15 18:27:34.763 INFO [stdout] running 6 tests Dec 15 18:27:34.769 INFO [stdout] test cancel_after_success ... ok Dec 15 18:27:34.770 INFO [stdout] test poll_after_cancel ... ok Dec 15 18:27:34.770 INFO [stdout] test poll_after_error ... ok Dec 15 18:27:34.770 INFO [stdout] test cancel_after_error ... ok Dec 15 18:27:34.770 INFO [stdout] test cancel_after_cancel ... ok Dec 15 18:27:34.776 INFO [stdout] test poll_after_success ... ok Dec 15 18:27:34.776 INFO [stderr] Running /target/debug/deps/if_cmd-a061d24a0a229db0 Dec 15 18:27:34.776 INFO [stdout] Dec 15 18:27:34.776 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.776 INFO [stdout] Dec 15 18:27:34.791 INFO [stdout] Dec 15 18:27:34.791 INFO [stdout] running 4 tests Dec 15 18:27:34.832 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:34.836 INFO [stdout] test should_propagate_fatal_errors ... ok Dec 15 18:27:34.836 INFO [stderr] if_cmd-a061d24a0a229db0: mock fatal error Dec 15 18:27:34.837 INFO [stdout] test should_run_body_of_successful_guard ... ok Dec 15 18:27:34.844 INFO [stdout] test should_run_else_branch_if_present_and_no_successful_guards ... ok Dec 15 18:27:34.844 INFO [stdout] Dec 15 18:27:34.844 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.844 INFO [stdout] Dec 15 18:27:34.848 INFO [stderr] Running /target/debug/deps/invert-b3bdec0e7f5ab301 Dec 15 18:27:34.859 INFO [stdout] Dec 15 18:27:34.859 INFO [stdout] running 4 tests Dec 15 18:27:34.859 INFO [stdout] test inverted_should_swallow_errors ... ok Dec 15 18:27:34.859 INFO [stdout] test inverted_should_invert_status ... ok Dec 15 18:27:34.859 INFO [stdout] test non_inverted_should_pass_error_along ... ok Dec 15 18:27:34.859 INFO [stdout] test non_inverted_should_pass_status_along ... ok Dec 15 18:27:34.859 INFO [stdout] Dec 15 18:27:34.859 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:34.859 INFO [stdout] Dec 15 18:27:34.859 INFO [stderr] Running /target/debug/deps/listable-a4fe439d9c6fd01e Dec 15 18:27:34.895 INFO [stdout] Dec 15 18:27:34.895 INFO [stdout] running 13 tests Dec 15 18:27:34.976 INFO [stdout] test single_command_env_changes_remain ... ok Dec 15 18:27:34.977 INFO [stdout] test empty_pipeline_is_noop ... ok Dec 15 18:27:35.018 INFO [stdout] test multiple_commands_propagates_last_status ... ok Dec 15 18:27:35.025 INFO [stdout] test multiple_commands_smoke ... ok Dec 15 18:27:35.029 INFO [stdout] test multiple_commands_swallows_inner_errors ... ok Dec 15 18:27:35.069 INFO [stdout] test multiple_commands_status_inversion_on_error ... ok Dec 15 18:27:35.069 INFO [stdout] test multiple_commands_status_inversion ... ok Dec 15 18:27:35.072 INFO [stdout] test multiple_commands_propagates_last_error ... ok Dec 15 18:27:35.082 INFO [stdout] test single_command_propagates_error ... ok Dec 15 18:27:35.087 INFO [stdout] test single_command_status_inversion_on_error ... ok Dec 15 18:27:35.096 INFO [stdout] test single_command_propagates_status ... ok Dec 15 18:27:35.096 INFO [stdout] test single_command_should_propagate_cancel ... ok Dec 15 18:27:35.096 INFO [stdout] test single_command_status_inversion ... ok Dec 15 18:27:35.096 INFO [stdout] Dec 15 18:27:35.096 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.096 INFO [stdout] Dec 15 18:27:35.105 INFO [stderr] Running /target/debug/deps/local_redirections-a76ac23147ce44c5 Dec 15 18:27:35.127 INFO [stdout] Dec 15 18:27:35.127 INFO [stdout] running 6 tests Dec 15 18:27:35.130 INFO [stdout] test fds_restored_after_cmd_or_redirect_error ... ok Dec 15 18:27:35.131 INFO [stdout] test last_redirect_seen_by_command_then_fds_restored_but_side_effects_remain ... ok Dec 15 18:27:35.131 INFO [stdout] test spawn_compound_command_smoke ... ok Dec 15 18:27:35.132 INFO [stdout] test cancel_should_restore_environment_fds_but_retain_other_side_effects ... ok Dec 15 18:27:35.144 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:35.149 INFO [stdout] test should_propagate_errors ... ok Dec 15 18:27:35.149 INFO [stdout] Dec 15 18:27:35.149 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.149 INFO [stdout] Dec 15 18:27:35.153 INFO [stderr] Running /target/debug/deps/loop_cmd-36a5cd697338bd80 Dec 15 18:27:35.155 INFO [stdout] Dec 15 18:27:35.155 INFO [stdout] running 5 tests Dec 15 18:27:35.159 INFO [stdout] test should_bail_on_empty_commands ... ok Dec 15 18:27:35.208 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:35.209 INFO [stdout] test should_not_run_body_if_guard_unsuccessful ... ok Dec 15 18:27:35.213 INFO [stdout] test should_propagate_fatal_errors ... ok Dec 15 18:27:35.213 INFO [stderr] loop_cmd-36a5cd697338bd80: mock fatal error Dec 15 18:27:35.214 INFO [stdout] test should_run_body_of_successful_guard ... ok Dec 15 18:27:35.214 INFO [stdout] Dec 15 18:27:35.214 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.214 INFO [stdout] Dec 15 18:27:35.217 INFO [stderr] Running /target/debug/deps/param_subst-d143563420fae69c Dec 15 18:27:35.231 INFO [stdout] Dec 15 18:27:35.231 INFO [stdout] running 3 tests Dec 15 18:27:35.252 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.253 INFO [stderr] param_subst-d143563420fae69c: mock non-fatal error Dec 15 18:27:35.256 INFO [stderr] param_subst-d143563420fae69c: mock non-fatal error Dec 15 18:27:35.298 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.426 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.427 INFO [stdout] Dec 15 18:27:35.427 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.427 INFO [stdout] Dec 15 18:27:35.433 INFO [stderr] Running /target/debug/deps/param_subst_alternative-0df94b545b08623f Dec 15 18:27:35.439 INFO [stdout] Dec 15 18:27:35.440 INFO [stdout] running 3 tests Dec 15 18:27:35.440 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.440 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.440 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.440 INFO [stdout] Dec 15 18:27:35.440 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.440 INFO [stdout] Dec 15 18:27:35.441 INFO [stderr] Running /target/debug/deps/param_subst_assign-f8706265e2fdee40 Dec 15 18:27:35.481 INFO [stdout] Dec 15 18:27:35.481 INFO [stdout] running 3 tests Dec 15 18:27:35.484 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.484 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.486 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.486 INFO [stderr] Running /target/debug/deps/param_subst_default-0cabf33ef7127b20 Dec 15 18:27:35.486 INFO [stdout] Dec 15 18:27:35.486 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.486 INFO [stdout] Dec 15 18:27:35.499 INFO [stdout] Dec 15 18:27:35.500 INFO [stderr] Running /target/debug/deps/param_subst_error-fe4743bc1eb73901 Dec 15 18:27:35.500 INFO [stdout] running 3 tests Dec 15 18:27:35.500 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.500 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.500 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.500 INFO [stdout] Dec 15 18:27:35.500 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.500 INFO [stdout] Dec 15 18:27:35.510 INFO [stdout] Dec 15 18:27:35.510 INFO [stdout] running 3 tests Dec 15 18:27:35.513 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.513 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.513 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.513 INFO [stdout] Dec 15 18:27:35.513 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.513 INFO [stdout] Dec 15 18:27:35.514 INFO [stderr] Running /target/debug/deps/param_subst_len-635dee5c43122f56 Dec 15 18:27:35.517 INFO [stdout] Dec 15 18:27:35.517 INFO [stdout] running 5 tests Dec 15 18:27:35.527 INFO [stderr] Running /target/debug/deps/param_subst_remove_largest_prefix-eb5db4048fbd7938 Dec 15 18:27:35.527 INFO [stdout] test split ... ok Dec 15 18:27:35.527 INFO [stdout] test at ... ok Dec 15 18:27:35.527 INFO [stdout] test none ... ok Dec 15 18:27:35.527 INFO [stdout] test zero ... ok Dec 15 18:27:35.527 INFO [stdout] test star ... ok Dec 15 18:27:35.527 INFO [stdout] Dec 15 18:27:35.527 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.527 INFO [stdout] Dec 15 18:27:35.527 INFO [stdout] Dec 15 18:27:35.527 INFO [stdout] running 3 tests Dec 15 18:27:35.533 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.533 INFO [stderr] Running /target/debug/deps/param_subst_remove_largest_suffix-5eaf61c32e418241 Dec 15 18:27:35.533 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.533 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.533 INFO [stdout] Dec 15 18:27:35.533 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.533 INFO [stdout] Dec 15 18:27:35.555 INFO [stdout] Dec 15 18:27:35.556 INFO [stdout] running 3 tests Dec 15 18:27:35.556 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.556 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.556 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.556 INFO [stdout] Dec 15 18:27:35.556 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.556 INFO [stdout] Dec 15 18:27:35.556 INFO [stderr] Running /target/debug/deps/param_subst_remove_smallest_prefix-0be8d5d2865ee29e Dec 15 18:27:35.568 INFO [stdout] Dec 15 18:27:35.568 INFO [stdout] running 3 tests Dec 15 18:27:35.579 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.579 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.579 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.579 INFO [stdout] Dec 15 18:27:35.579 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.579 INFO [stdout] Dec 15 18:27:35.580 INFO [stderr] Running /target/debug/deps/param_subst_remove_smallest_suffix-9cf818249bcccc47 Dec 15 18:27:35.584 INFO [stdout] Dec 15 18:27:35.584 INFO [stdout] running 3 tests Dec 15 18:27:35.588 INFO [stdout] test should_propagate_cancel_if_required ... ok Dec 15 18:27:35.590 INFO [stdout] test should_propagate_errors_from_word_if_applicable ... ok Dec 15 18:27:35.591 INFO [stdout] test should_evaluate_appropriately ... ok Dec 15 18:27:35.591 INFO [stdout] Dec 15 18:27:35.591 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.591 INFO [stdout] Dec 15 18:27:35.593 INFO [stderr] Running /target/debug/deps/parameter-45150acf2bf06892 Dec 15 18:27:35.615 INFO [stdout] Dec 15 18:27:35.615 INFO [stdout] running 5 tests Dec 15 18:27:35.662 INFO [stdout] test test_eval_parameter_with_unset_vars ... ok Dec 15 18:27:35.679 INFO [stdout] test test_eval_parameter_splitting_with_default_ifs ... ok Dec 15 18:27:35.679 INFO [stdout] test test_eval_parameter_splitting_with_empty_ifs ... ok Dec 15 18:27:35.679 INFO [stdout] test test_eval_parameter_splitting_with_custom_ifs ... ok Dec 15 18:27:35.679 INFO [stdout] test test_eval_parameter_with_set_vars ... ok Dec 15 18:27:35.679 INFO [stdout] Dec 15 18:27:35.679 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.679 INFO [stdout] Dec 15 18:27:35.683 INFO [stdout] Dec 15 18:27:35.683 INFO [stderr] Running /target/debug/deps/path-c22980541e8cf327 Dec 15 18:27:35.683 INFO [stdout] running 5 tests Dec 15 18:27:35.683 INFO [stdout] test new_normalized_logical_normalizes_relative_paths ... ok Dec 15 18:27:35.691 INFO [stdout] test join_logical_normalizes_root_paths ... ok Dec 15 18:27:35.691 INFO [stdout] test join_logical_normalizes_relative_paths ... ok Dec 15 18:27:35.692 INFO [stdout] test new_normalized_logical_normalizes_root_paths ... ok Dec 15 18:27:35.692 INFO [stdout] test join_physical_normalizes_paths_and_resolves_symlinks ... ok Dec 15 18:27:35.692 INFO [stdout] Dec 15 18:27:35.692 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.692 INFO [stdout] Dec 15 18:27:35.692 INFO [stderr] Running /target/debug/deps/permissions-73b108d6262904ef Dec 15 18:27:35.702 INFO [stdout] Dec 15 18:27:35.702 INFO [stdout] running 5 tests Dec 15 18:27:35.706 INFO [stdout] test test_permissions_readable ... ok Dec 15 18:27:35.711 INFO [stdout] test test_permissions_writable ... ok Dec 15 18:27:35.812 INFO [stdout] test test_permissions_open_read ... ok Dec 15 18:27:35.812 INFO [stdout] test test_permissions_open_write ... ok Dec 15 18:27:35.923 INFO [stdout] test test_permissions_open_readwrite ... ok Dec 15 18:27:35.923 INFO [stdout] Dec 15 18:27:35.923 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.923 INFO [stdout] Dec 15 18:27:35.923 INFO [stdout] Dec 15 18:27:35.923 INFO [stdout] running 2 tests Dec 15 18:27:35.923 INFO [stdout] test unwrap_and_cancel ... ok Dec 15 18:27:35.923 INFO [stderr] Running /target/debug/deps/pinned-a984a7a7254f2e8b Dec 15 18:27:35.929 INFO [stdout] test smoke ... ok Dec 15 18:27:35.929 INFO [stdout] Dec 15 18:27:35.929 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.929 INFO [stdout] Dec 15 18:27:35.931 INFO [stderr] Running /target/debug/deps/pipeable-46ea49f7e4eccebb Dec 15 18:27:35.936 INFO [stdout] Dec 15 18:27:35.936 INFO [stdout] running 3 tests Dec 15 18:27:35.943 INFO [stderr] Running /target/debug/deps/pwd-a992ed862f183f34 Dec 15 18:27:35.943 INFO [stdout] test should_propagate_errors ... ok Dec 15 18:27:35.943 INFO [stdout] test smoke ... ok Dec 15 18:27:35.943 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:35.943 INFO [stdout] Dec 15 18:27:35.943 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:35.943 INFO [stdout] Dec 15 18:27:36.031 INFO [stdout] Dec 15 18:27:36.031 INFO [stdout] running 9 tests Dec 15 18:27:36.184 INFO [stdout] test logical_behaves_as_physical_if_dot_components_present ... ok Dec 15 18:27:36.199 INFO [stdout] test no_arg_behaves_as_physical_if_dot_components_present ... ok Dec 15 18:27:36.199 INFO [stdout] test physical_removes_dot_components ... ok Dec 15 18:27:36.199 INFO [stdout] test physical ... ok Dec 15 18:27:36.211 INFO [stdout] test logical ... ok Dec 15 18:27:36.211 INFO [stdout] test successful_if_no_stdout ... ok Dec 15 18:27:36.211 INFO [stdout] test no_arg_behaves_as_logical ... ok Dec 15 18:27:36.223 INFO [stdout] test last_specified_flag_wins ... ok Dec 15 18:27:36.435 INFO [stdout] test polling_canceled_pwd_panics ... ok Dec 15 18:27:36.435 INFO [stdout] Dec 15 18:27:36.435 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:36.435 INFO [stdout] Dec 15 18:27:36.441 INFO [stderr] Running /target/debug/deps/rc-2335b6ac365740d3 Dec 15 18:27:36.446 INFO [stdout] Dec 15 18:27:36.446 INFO [stdout] running 2 tests Dec 15 18:27:36.527 INFO [stdout] test cancel_smoke ... ok Dec 15 18:27:36.527 INFO [stdout] test smoke ... ok Dec 15 18:27:36.527 INFO [stdout] Dec 15 18:27:36.527 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:36.527 INFO [stdout] Dec 15 18:27:36.547 INFO [stderr] Running /target/debug/deps/redirect-ed53b7f75ae1057f Dec 15 18:27:36.576 INFO [stdout] Dec 15 18:27:36.576 INFO [stdout] running 13 tests Dec 15 18:27:36.591 INFO [stdout] test apply_redirect_action ... ok Dec 15 18:27:36.687 INFO [stdout] test eval_read_write ... ok Dec 15 18:27:36.717 INFO [stdout] test eval_path_is_relative_to_cwd ... ok Dec 15 18:27:36.809 INFO [stdout] test eval_read ... ok Dec 15 18:27:36.831 INFO [stdout] test eval_write_and_clobber ... ok Dec 15 18:27:36.861 INFO [stdout] test eval_append ... ok Dec 15 18:27:36.867 INFO [stdout] test should_eval_dup_close_approprately ... ok Dec 15 18:27:36.878 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:36.881 INFO [stdout] test should_eval_dup_raises_appropriate_perms_or_bad_src_errors ... ok Dec 15 18:27:36.915 INFO [stdout] test should_split_word_fields_if_interactive_and_expand_first_tilde ... ok Dec 15 18:27:37.055 INFO [stdout] test eval_heredoc ... ok Dec 15 18:27:37.087 INFO [stdout] test should_propagate_errors ... ok Dec 15 18:27:37.296 INFO [stdout] test eval_ambiguous_path ... ok Dec 15 18:27:37.296 INFO [stdout] Dec 15 18:27:37.296 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.296 INFO [stdout] Dec 15 18:27:37.315 INFO [stderr] Running /target/debug/deps/redirect_or_cmd_word-629373a5d9da555d Dec 15 18:27:37.350 INFO [stdout] Dec 15 18:27:37.350 INFO [stdout] running 3 tests Dec 15 18:27:37.353 INFO [stdout] test smoke ... ok Dec 15 18:27:37.354 INFO [stdout] test should_propagate_errors_and_restore_redirects ... ok Dec 15 18:27:37.358 INFO [stdout] test should_propagate_cancel_and_restore_redirects ... ok Dec 15 18:27:37.358 INFO [stdout] Dec 15 18:27:37.358 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.358 INFO [stdout] Dec 15 18:27:37.359 INFO [stderr] Running /target/debug/deps/redirect_or_var_assig-633c93458ffa5ec6 Dec 15 18:27:37.364 INFO [stdout] Dec 15 18:27:37.364 INFO [stdout] running 4 tests Dec 15 18:27:37.431 INFO [stdout] test should_propagate_errors_and_restore_redirects_and_vars ... ok Dec 15 18:27:37.431 INFO [stdout] test should_honor_export_vars_config ... ok Dec 15 18:27:37.432 INFO [stdout] test should_propagate_cancel_and_restore_redirects_and_vars ... ok Dec 15 18:27:37.435 INFO [stdout] test smoke ... ok Dec 15 18:27:37.435 INFO [stdout] Dec 15 18:27:37.435 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.435 INFO [stdout] Dec 15 18:27:37.443 INFO [stderr] Running /target/debug/deps/redirect_or_var_assig_deprecated-ecf815eeda3eb0c5 Dec 15 18:27:37.471 INFO [stdout] Dec 15 18:27:37.471 INFO [stdout] running 3 tests Dec 15 18:27:37.476 INFO [stdout] test should_propagate_cancel_and_restore_redirects ... ok Dec 15 18:27:37.476 INFO [stdout] test should_propagate_errors_and_restore_redirects ... ok Dec 15 18:27:37.477 INFO [stdout] test smoke ... ok Dec 15 18:27:37.477 INFO [stdout] Dec 15 18:27:37.477 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.477 INFO [stdout] Dec 15 18:27:37.483 INFO [stderr] Running /target/debug/deps/report_error-c50474c639625d99 Dec 15 18:27:37.503 INFO [stdout] Dec 15 18:27:37.503 INFO [stdout] running 1 test Dec 15 18:27:37.535 INFO [stdout] test smoke ... ok Dec 15 18:27:37.535 INFO [stdout] Dec 15 18:27:37.535 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.535 INFO [stdout] Dec 15 18:27:37.535 INFO [stderr] Running /target/debug/deps/reversible_redirect-f774a9724af585d9 Dec 15 18:27:37.571 INFO [stdout] Dec 15 18:27:37.571 INFO [stdout] running 1 test Dec 15 18:27:37.571 INFO [stdout] test smoke ... ok Dec 15 18:27:37.571 INFO [stdout] Dec 15 18:27:37.571 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.571 INFO [stdout] Dec 15 18:27:37.571 INFO [stderr] Running /target/debug/deps/reversible_var-8dfcf415a3cf0cae Dec 15 18:27:37.594 INFO [stdout] Dec 15 18:27:37.594 INFO [stdout] running 1 test Dec 15 18:27:37.594 INFO [stdout] test smoke ... ok Dec 15 18:27:37.594 INFO [stdout] Dec 15 18:27:37.594 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.594 INFO [stdout] Dec 15 18:27:37.594 INFO [stderr] Running /target/debug/deps/sequence-9f1be6ac9c2ca33d Dec 15 18:27:37.613 INFO [stdout] Dec 15 18:27:37.613 INFO [stdout] running 6 tests Dec 15 18:27:37.645 INFO [stderr] sequence-9f1be6ac9c2ca33d: mock fatal error Dec 15 18:27:37.647 INFO [stdout] test should_swallow_non_fatal_errors ... ok Dec 15 18:27:37.647 INFO [stdout] test single_command_sequence_should_propagate_cancel_to_current_command ... ok Dec 15 18:27:37.648 INFO [stdout] test should_resolve_to_last_status ... ok Dec 15 18:27:37.648 INFO [stdout] test multiple_command_sequence_should_propagate_cancel_to_current_command ... ok Dec 15 18:27:37.659 INFO [stdout] test should_resolve_successfully_for_no_commands ... ok Dec 15 18:27:37.663 INFO [stdout] test should_terminate_on_fatal_errors ... ok Dec 15 18:27:37.663 INFO [stdout] Dec 15 18:27:37.663 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:37.663 INFO [stdout] Dec 15 18:27:37.670 INFO [stderr] Running /target/debug/deps/shift-7b80b5df6bb8552c Dec 15 18:27:37.685 INFO [stdout] Dec 15 18:27:37.685 INFO [stdout] running 7 tests Dec 15 18:27:37.808 INFO [stdout] test shift_with_args ... ok Dec 15 18:27:37.808 INFO [stdout] test shift_no_args_shifts_by_one ... ok Dec 15 18:27:37.808 INFO [stdout] test shift_negative_arg_does_nothing_and_exit_with_error ... ok Dec 15 18:27:37.808 INFO [stdout] test shift_large_arg_does_nothing_and_exit_with_error ... ok Dec 15 18:27:37.808 INFO [stdout] test shift_multiple_arg_does_nothing_and_exit_with_error ... ok Dec 15 18:27:37.811 INFO [stdout] test shift_non_numeric_arg_does_nothing_and_exit_with_error ... ok Dec 15 18:27:38.022 INFO [stdout] test polling_canceled_shift_panics ... ok Dec 15 18:27:38.023 INFO [stdout] Dec 15 18:27:38.023 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.023 INFO [stdout] Dec 15 18:27:38.030 INFO [stderr] Running /target/debug/deps/simple-c21a3ce6e1bb0e87 Dec 15 18:27:38.034 INFO [stdout] Dec 15 18:27:38.035 INFO [stdout] running 7 tests Dec 15 18:27:38.079 INFO [stdout] test command_with_no_words_should_open_and_restore_redirects_and_assign_vars ... ok Dec 15 18:27:38.167 INFO [stdout] test should_propagate_cancel_and_restore_redirects_and_vars ... ok Dec 15 18:27:38.167 INFO [stdout] test should_propagate_errors_and_restore_redirects_without_assigning_vars ... ok Dec 15 18:27:38.167 INFO [stdout] test command_redirect_and_env_var_overrides ... ok Dec 15 18:27:38.167 INFO [stdout] test function_smoke ... ok Dec 15 18:27:38.167 INFO [stdout] test ast_node_smoke_test ... ok Dec 15 18:27:38.167 INFO [stdout] test should_set_executable_cwd_same_as_env ... ok Dec 15 18:27:38.167 INFO [stdout] Dec 15 18:27:38.167 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.167 INFO [stdout] Dec 15 18:27:38.167 INFO [stdout] Dec 15 18:27:38.167 INFO [stdout] running 10 tests Dec 15 18:27:38.167 INFO [stderr] Running /target/debug/deps/simple_word-f403a777868b8b57 Dec 15 18:27:38.218 INFO [stdout] test test_lone_tilde_expansion ... ok Dec 15 18:27:38.284 INFO [stdout] test test_param_splitting ... ok Dec 15 18:27:38.284 INFO [stdout] test test_subst_error ... ok Dec 15 18:27:38.284 INFO [stdout] test test_subst_cancel ... ok Dec 15 18:27:38.380 INFO [stdout] test test_escaped_eval ... ok Dec 15 18:27:38.381 INFO [stdout] test test_param_unset ... ok Dec 15 18:27:38.387 INFO [stdout] test test_literal_eval ... ok Dec 15 18:27:38.387 INFO [stdout] test test_param ... ok Dec 15 18:27:38.387 INFO [stdout] test test_subst ... ok Dec 15 18:27:38.419 INFO [stdout] test test_special_literals_eval_properly ... ok Dec 15 18:27:38.419 INFO [stderr] Running /target/debug/deps/split-f08ab55f9d2aa593 Dec 15 18:27:38.419 INFO [stdout] Dec 15 18:27:38.419 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.419 INFO [stdout] Dec 15 18:27:38.431 INFO [stdout] Dec 15 18:27:38.431 INFO [stdout] running 3 tests Dec 15 18:27:38.431 INFO [stdout] test should_propagate_errors ... ok Dec 15 18:27:38.431 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:38.432 INFO [stdout] test should_split_fields_as_requested ... ok Dec 15 18:27:38.432 INFO [stdout] Dec 15 18:27:38.432 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.432 INFO [stdout] Dec 15 18:27:38.439 INFO [stderr] Running /target/debug/deps/subshell-d50bcc17069caddc Dec 15 18:27:38.463 INFO [stdout] Dec 15 18:27:38.463 INFO [stdout] running 5 tests Dec 15 18:27:38.479 INFO [stdout] test should_resolve_successfully_for_no_commands ... ok Dec 15 18:27:38.515 INFO [stdout] test should_isolate_parent_env_from_any_changes ... ok Dec 15 18:27:38.515 INFO [stderr] subshell-d50bcc17069caddc: mock fatal error Dec 15 18:27:38.515 INFO [stderr] subshell-d50bcc17069caddc: mock non-fatal error Dec 15 18:27:38.515 INFO [stdout] test should_resolve_to_last_status ... ok Dec 15 18:27:38.515 INFO [stdout] test should_terminate_on_fatal_errors_but_swallow_them ... ok Dec 15 18:27:38.525 INFO [stderr] subshell-d50bcc17069caddc: mock non-fatal error Dec 15 18:27:38.525 INFO [stdout] test should_swallow_errors ... ok Dec 15 18:27:38.525 INFO [stdout] Dec 15 18:27:38.525 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.525 INFO [stdout] Dec 15 18:27:38.531 INFO [stderr] Running /target/debug/deps/substitution-aabbc3346ca3c169 Dec 15 18:27:38.551 INFO [stdout] Dec 15 18:27:38.551 INFO [stdout] running 4 tests Dec 15 18:27:38.607 INFO [stderr] substitution-aabbc3346ca3c169: mock fatal error Dec 15 18:27:38.607 INFO [stdout] test should_resolve_successfully_for_no_commands ... ok Dec 15 18:27:38.635 INFO [stdout] test should_resolve_to_cmd_output ... ok Dec 15 18:27:38.647 INFO [stdout] test should_trim_trailing_newlines ... ok Dec 15 18:27:38.647 INFO [stderr] substitution-aabbc3346ca3c169: mock non-fatal error Dec 15 18:27:38.647 INFO [stdout] test should_swallow_errors_and_return_partial_output ... ok Dec 15 18:27:38.647 INFO [stdout] Dec 15 18:27:38.647 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.647 INFO [stdout] Dec 15 18:27:38.651 INFO [stderr] Running /target/debug/deps/support-7b7e39476e9e3c52 Dec 15 18:27:38.664 INFO [stdout] Dec 15 18:27:38.664 INFO [stdout] running 0 tests Dec 15 18:27:38.664 INFO [stdout] Dec 15 18:27:38.664 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.664 INFO [stdout] Dec 15 18:27:38.671 INFO [stderr] Running /target/debug/deps/swallow_non_fatal-50103d25392b1edb Dec 15 18:27:38.699 INFO [stdout] Dec 15 18:27:38.699 INFO [stdout] running 4 tests Dec 15 18:27:38.699 INFO [stdout] test should_propagate_cancel ... ok Dec 15 18:27:38.759 INFO [stdout] test should_swallow_non_fatal_errors ... ok Dec 15 18:27:38.759 INFO [stderr] swallow_non_fatal-50103d25392b1edb: mock fatal error Dec 15 18:27:38.811 INFO [stdout] test should_propagate_result ... ok Dec 15 18:27:38.811 INFO [stdout] test should_propagate_fatal_errors ... ok Dec 15 18:27:38.811 INFO [stdout] Dec 15 18:27:38.811 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.811 INFO [stdout] Dec 15 18:27:38.813 INFO [stderr] Running /target/debug/deps/top_level_impl-d621b4e81f7fdaa4 Dec 15 18:27:38.830 INFO [stdout] Dec 15 18:27:38.830 INFO [stdout] running 2 tests Dec 15 18:27:38.924 INFO [stdout] test smoke ... ok Dec 15 18:27:38.925 INFO [stdout] test smoke_atomic ... ok Dec 15 18:27:38.925 INFO [stdout] Dec 15 18:27:38.925 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.925 INFO [stdout] Dec 15 18:27:38.927 INFO [stderr] Running /target/debug/deps/true_cmd-90d93ab14fa62231 Dec 15 18:27:38.951 INFO [stdout] Dec 15 18:27:38.951 INFO [stdout] running 1 test Dec 15 18:27:38.955 INFO [stdout] test true_smoke ... ok Dec 15 18:27:38.955 INFO [stdout] Dec 15 18:27:38.955 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:38.955 INFO [stdout] Dec 15 18:27:38.959 INFO [stderr] Running /target/debug/deps/word-200338804ec90718 Dec 15 18:27:38.986 INFO [stdout] Dec 15 18:27:38.986 INFO [stdout] running 12 tests Dec 15 18:27:39.002 INFO [stdout] test test_double_quoted_cancel ... ok Dec 15 18:27:39.023 INFO [stdout] test test_double_quoted_param_star_expands_but_joined_by_ifs ... ok Dec 15 18:27:39.057 INFO [stdout] test test_double_quoted_does_not_expand_tilde ... ok Dec 15 18:27:39.064 INFO [stdout] test test_simple_cancel ... ok Dec 15 18:27:39.071 INFO [stdout] test test_double_quoted_no_field_splitting ... ok Dec 15 18:27:39.071 INFO [stdout] test test_single_quoted_should_not_split_fields_or_expand_anything ... ok Dec 15 18:27:39.079 INFO [stdout] test test_double_quoted_joins_multiple_single_expansions_as_single_field ... ok Dec 15 18:27:39.122 INFO [stdout] test test_double_quoted_param_at_zero_fields_if_no_args ... ok Dec 15 18:27:39.128 INFO [stdout] test test_double_quoted_param_at_expands_to_nothing_when_args_not_set_and_concats_with_rest ... ok Dec 15 18:27:39.130 INFO [stdout] test test_double_quoted_param_at_expands_when_args_set_and_concats_with_rest ... ok Dec 15 18:27:39.131 INFO [stdout] test test_double_quoted_param_star_unset_results_in_no_fields ... ok Dec 15 18:27:39.139 INFO [stdout] test test_simple ... ok Dec 15 18:27:39.139 INFO [stdout] Dec 15 18:27:39.139 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:39.139 INFO [stdout] Dec 15 18:27:39.154 INFO [stdout] Dec 15 18:27:39.155 INFO [stderr] Running /target/debug/deps/word_eval-2961e351ccafdf12 Dec 15 18:27:39.155 INFO [stdout] running 5 tests Dec 15 18:27:39.158 INFO [stdout] test test_assignment_cancel ... ok Dec 15 18:27:39.159 INFO [stdout] test test_eval_expands_first_tilde_and_splits_words ... ok Dec 15 18:27:39.159 INFO [stdout] test test_eval_as_pattern_expands_first_tilde_and_does_not_split_words_and_joins_fields ... ok Dec 15 18:27:39.159 INFO [stdout] test test_eval_as_assignment_expands_all_tilde_and_does_not_split_words ... ok Dec 15 18:27:39.159 INFO [stdout] test test_pattern_cancel ... ok Dec 15 18:27:39.159 INFO [stdout] Dec 15 18:27:39.159 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:27:39.159 INFO [stdout] Dec 15 18:27:39.163 INFO [stderr] Doc-tests conch-runtime Dec 15 18:27:48.660 INFO [stdout] Dec 15 18:27:48.660 INFO [stdout] running 6 tests Dec 15 18:28:13.470 INFO [stdout] test src/env/env_impl.rs - env::env_impl::DefaultAtomicEnv (line 808) ... ok Dec 15 18:28:13.759 INFO [stdout] test src/env/env_impl.rs - env::env_impl::DefaultEnvConfig (line 225) ... ok Dec 15 18:28:15.191 INFO [stdout] test src/env/env_impl.rs - env::env_impl::DefaultEnv (line 770) ... ok Dec 15 18:28:16.046 INFO [stdout] test src/env/env_impl.rs - env::env_impl::DefaultAtomicEnvConfig (line 261) ... ok Dec 15 18:28:16.770 INFO [stdout] test src/env/env_impl.rs - env::env_impl::EnvConfig (line 34) ... ok Dec 15 18:28:16.827 INFO [stdout] test src/sys/unix/io/fd_ext.rs - sys::io::fd_ext::FileDescExt (line 23) ... ok Dec 15 18:28:16.827 INFO [stdout] Dec 15 18:28:16.827 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 18:28:16.827 INFO [stdout] Dec 15 18:28:16.861 INFO [stderr] su: No module specific data is present Dec 15 18:28:17.220 INFO running `"docker" "inspect" "b8aba223c4ed1a1aaa942e6b04c2c8cdaeccbcf5ad6a47f47e9e54de974fd2b6"` Dec 15 18:28:17.301 INFO running `"docker" "rm" "-f" "b8aba223c4ed1a1aaa942e6b04c2c8cdaeccbcf5ad6a47f47e9e54de974fd2b6"` Dec 15 18:28:17.403 INFO [stdout] b8aba223c4ed1a1aaa942e6b04c2c8cdaeccbcf5ad6a47f47e9e54de974fd2b6