Dec 14 22:10:01.562 INFO testing run_script-0.2.3 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 22:10:01.562 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14 22:10:01.851 INFO [stdout] 1e20bba41dcff70c8c6f1f6a967765cfbffb8e494955e75b2c5525fff19bc687
Dec 14 22:10:01.853 INFO running `"docker" "start" "-a" "1e20bba41dcff70c8c6f1f6a967765cfbffb8e494955e75b2c5525fff19bc687"`
Dec 14 22:10:02.773 INFO [stderr] usermod: no changes
Dec 14 22:10:02.855 INFO [stderr]    Compiling users v0.8.1
Dec 14 22:10:04.975 INFO [stderr]    Compiling run_script v0.2.3 (/source)
Dec 14 22:10:05.029 INFO [stderr] warning: unknown lint: `duplicate_associated_type_bindings`
Dec 14 22:10:05.029 INFO [stderr]  --> src/lib.rs:7:5
Dec 14 22:10:05.029 INFO [stderr]   |
Dec 14 22:10:05.029 INFO [stderr] 7 |     duplicate_associated_type_bindings,
Dec 14 22:10:05.029 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 22:10:05.029 INFO [stderr]   |
Dec 14 22:10:05.029 INFO [stderr]   = note: #[warn(unknown_lints)] on by default
Dec 14 22:10:05.029 INFO [stderr] 
Dec 14 22:10:06.643 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.85s
Dec 14 22:10:06.651 INFO [stderr] su: No module specific data is present
Dec 14 22:10:07.074 INFO running `"docker" "inspect" "1e20bba41dcff70c8c6f1f6a967765cfbffb8e494955e75b2c5525fff19bc687"`
Dec 14 22:10:07.176 INFO running `"docker" "rm" "-f" "1e20bba41dcff70c8c6f1f6a967765cfbffb8e494955e75b2c5525fff19bc687"`
Dec 14 22:10:07.272 INFO [stdout] 1e20bba41dcff70c8c6f1f6a967765cfbffb8e494955e75b2c5525fff19bc687
Dec 14 22:10:07.273 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14 22:10:07.460 INFO [stdout] 725e94b9d9984ab09bc6e3e97b48f0c8bf36d237eb5c3e982a7512002a0caa2e
Dec 14 22:10:07.462 INFO running `"docker" "start" "-a" "725e94b9d9984ab09bc6e3e97b48f0c8bf36d237eb5c3e982a7512002a0caa2e"`
Dec 14 22:10:07.817 INFO [stderr] usermod: no changes
Dec 14 22:10:07.872 INFO [stderr]    Compiling run_script v0.2.3 (/source)
Dec 14 22:10:07.923 INFO [stderr] warning: unknown lint: `duplicate_associated_type_bindings`
Dec 14 22:10:07.923 INFO [stderr]  --> src/lib.rs:7:5
Dec 14 22:10:07.923 INFO [stderr]   |
Dec 14 22:10:07.923 INFO [stderr] 7 |     duplicate_associated_type_bindings,
Dec 14 22:10:07.923 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 22:10:07.923 INFO [stderr]   |
Dec 14 22:10:07.923 INFO [stderr]   = note: #[warn(unknown_lints)] on by default
Dec 14 22:10:07.923 INFO [stderr] 
Dec 14 22:10:11.420 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.58s
Dec 14 22:10:11.426 INFO [stderr] su: No module specific data is present
Dec 14 22:10:11.716 INFO running `"docker" "inspect" "725e94b9d9984ab09bc6e3e97b48f0c8bf36d237eb5c3e982a7512002a0caa2e"`
Dec 14 22:10:11.787 INFO running `"docker" "rm" "-f" "725e94b9d9984ab09bc6e3e97b48f0c8bf36d237eb5c3e982a7512002a0caa2e"`
Dec 14 22:10:11.881 INFO [stdout] 725e94b9d9984ab09bc6e3e97b48f0c8bf36d237eb5c3e982a7512002a0caa2e
Dec 14 22:10:11.890 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14 22:10:12.067 INFO [stdout] b1e5d564025866142203739792b4af92adaefb8a16713d07a5905323b34f5f3b
Dec 14 22:10:12.072 INFO running `"docker" "start" "-a" "b1e5d564025866142203739792b4af92adaefb8a16713d07a5905323b34f5f3b"`
Dec 14 22:10:12.545 INFO [stderr] usermod: no changes
Dec 14 22:10:12.598 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 14 22:10:12.600 INFO [stderr]      Running /target/debug/deps/run_script-188d46f0b02f7baa
Dec 14 22:10:12.604 INFO [stdout] 
Dec 14 22:10:12.604 INFO [stdout] running 13 tests
Dec 14 22:10:12.605 INFO [stdout] test runner::runner_test::modify_script_no_shebang_default_options ... ok
Dec 14 22:10:12.605 INFO [stdout] test runner::runner_test::modify_script_exit_on_error ... ok
Dec 14 22:10:12.605 INFO [stdout] test runner::runner_test::modify_script_exit_on_error_and_print_commands ... ok
Dec 14 22:10:12.605 INFO [stdout] test runner::runner_test::modify_script_print_commands ... ok
Dec 14 22:10:12.605 INFO [stdout] test types::types_test::script_error_description ... ok
Dec 14 22:10:12.606 INFO [stdout] test types::types_test::script_options_new ... ok
Dec 14 22:10:12.608 INFO [stdout] test runner::runner_test::create_script_file_and_delete ... ok
Dec 14 22:10:12.615 INFO [stdout] test runner::runner_test::modify_script_with_shebang_default_options ... ok
Dec 14 22:10:12.616 INFO [stdout] test runner::runner_test::run_test_no_args_default_options ... ok
Dec 14 22:10:12.616 INFO [stdout] test lib_test::run_test ... ok
Dec 14 22:10:12.620 INFO [stdout] test runner::runner_test::run_test_error_execute ... ok
Dec 14 22:10:12.621 INFO [stdout] test runner::runner_test::run_test_error_exit_code ... ok
Dec 14 22:10:12.621 INFO [stdout] test runner::runner_test::run_test_with_args ... ok
Dec 14 22:10:12.621 INFO [stdout] 
Dec 14 22:10:12.621 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:10:12.621 INFO [stdout] 
Dec 14 22:10:12.623 INFO [stdout] 
Dec 14 22:10:12.623 INFO [stderr]      Running /target/debug/deps/marco_test-a7a7c3db03ac3e1a
Dec 14 22:10:12.624 INFO [stdout] running 4 tests
Dec 14 22:10:12.630 INFO [stdout] test run_macro_with_args_with_options ... ok
Dec 14 22:10:12.630 INFO [stdout] test run_macro_no_args_no_options_error_output ... ok
Dec 14 22:10:12.630 INFO [stdout] test run_macro_no_args_no_options_valid ... ok
Dec 14 22:10:12.631 INFO [stdout] test run_macro_no_args_with_options ... ok
Dec 14 22:10:12.631 INFO [stdout] 
Dec 14 22:10:12.631 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:10:12.631 INFO [stdout] 
Dec 14 22:10:12.632 INFO [stderr]      Running /target/debug/deps/run_test-39889329f30adbf5
Dec 14 22:10:12.633 INFO [stdout] 
Dec 14 22:10:12.633 INFO [stdout] running 1 test
Dec 14 22:10:12.639 INFO [stdout] test run_test ... ok
Dec 14 22:10:12.639 INFO [stdout] 
Dec 14 22:10:12.639 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:10:12.639 INFO [stdout] 
Dec 14 22:10:12.639 INFO [stderr]    Doc-tests run_script
Dec 14 22:10:14.194 INFO [stdout] 
Dec 14 22:10:14.195 INFO [stdout] running 5 tests
Dec 14 22:10:17.838 INFO [stdout] test src/lib.rs -  (line 136) ... ok
Dec 14 22:10:17.838 INFO [stdout] test src/lib.rs - run (line 220) ... ok
Dec 14 22:10:17.888 INFO [stdout] test src/runner.rs - runner::run (line 191) ... ok
Dec 14 22:10:17.988 INFO [stdout] test src/lib.rs -  (line 109) ... ok
Dec 14 22:10:18.118 INFO [stdout] test src/macros.rs - run_script (line 16) ... ok
Dec 14 22:10:18.118 INFO [stdout] 
Dec 14 22:10:18.118 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:10:18.118 INFO [stdout] 
Dec 14 22:10:18.133 INFO [stderr] su: No module specific data is present
Dec 14 22:10:18.376 INFO running `"docker" "inspect" "b1e5d564025866142203739792b4af92adaefb8a16713d07a5905323b34f5f3b"`
Dec 14 22:10:18.471 INFO running `"docker" "rm" "-f" "b1e5d564025866142203739792b4af92adaefb8a16713d07a5905323b34f5f3b"`
Dec 14 22:10:18.561 INFO [stdout] b1e5d564025866142203739792b4af92adaefb8a16713d07a5905323b34f5f3b