Oct 11 10:39:48.443 INFO testing subprocess-0.1.16 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 10:39:48.443 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 10:39:48.443 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 10:39:48.694 INFO blam! d991fb7d75cf5a01af8c81ef4bb768614d49897480220314689c73e26c858e7d
Oct 11 10:39:48.696 INFO running `"docker" "start" "-a" "d991fb7d75cf5a01af8c81ef4bb768614d49897480220314689c73e26c858e7d"`
Oct 11 10:39:49.271 INFO kablam! usermod: no changes
Oct 11 10:39:49.326 INFO kablam!    Compiling subprocess v0.1.16 (/source)
Oct 11 10:39:52.975 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 3.68s
Oct 11 10:39:52.976 INFO kablam! su: No module specific data is present
Oct 11 10:39:53.336 INFO running `"docker" "rm" "-f" "d991fb7d75cf5a01af8c81ef4bb768614d49897480220314689c73e26c858e7d"`
Oct 11 10:39:53.500 INFO blam! d991fb7d75cf5a01af8c81ef4bb768614d49897480220314689c73e26c858e7d
Oct 11 10:39:53.503 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 10:39:53.503 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 10:39:53.854 INFO blam! f6417a57cc13ac2af2abf636db1134dde2e8d8a2fc88150834bcaf9a07b6173d
Oct 11 10:39:53.856 INFO running `"docker" "start" "-a" "f6417a57cc13ac2af2abf636db1134dde2e8d8a2fc88150834bcaf9a07b6173d"`
Oct 11 10:39:54.880 INFO kablam! usermod: no changes
Oct 11 10:39:54.933 INFO kablam!    Compiling subprocess v0.1.16 (/source)
Oct 11 10:40:00.818 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 5.93s
Oct 11 10:40:00.822 INFO kablam! su: No module specific data is present
Oct 11 10:40:01.147 INFO running `"docker" "rm" "-f" "f6417a57cc13ac2af2abf636db1134dde2e8d8a2fc88150834bcaf9a07b6173d"`
Oct 11 10:40:01.208 INFO blam! f6417a57cc13ac2af2abf636db1134dde2e8d8a2fc88150834bcaf9a07b6173d
Oct 11 10:40:01.210 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 10:40:01.210 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 10:40:01.410 INFO blam! 396dc79430b5b65215e5d6f76f864f6fd7b77c58ad0783e7345e4a6fa73e85ba
Oct 11 10:40:01.411 INFO running `"docker" "start" "-a" "396dc79430b5b65215e5d6f76f864f6fd7b77c58ad0783e7345e4a6fa73e85ba"`
Oct 11 10:40:02.042 INFO kablam! usermod: no changes
Oct 11 10:40:02.088 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Oct 11 10:40:02.101 INFO kablam!      Running /target/debug/deps/subprocess-02ca18cfca682ef1
Oct 11 10:40:02.104 INFO blam! 
Oct 11 10:40:02.104 INFO blam! running 62 tests
Oct 11 10:40:02.104 INFO blam! test tests::builder::exec_to_string ... ok
Oct 11 10:40:02.105 INFO blam! test posix::tests::test_split_path ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::env_set ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::env_inherit_set ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::exec_shell ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::null_file ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::env_extend ... ok
Oct 11 10:40:02.120 INFO blam! test tests::builder::pipeline_invalid_2 ... ok
Oct 11 10:40:02.122 INFO blam! test tests::builder::env_inherit ... ok
Oct 11 10:40:02.130 INFO blam! test tests::builder::pipeline_invalid_1 ... ok
Oct 11 10:40:02.133 INFO blam! test tests::builder::pipeline_open ... ok
Oct 11 10:40:02.134 INFO blam! test tests::builder::pipeline_to_string ... ok
Oct 11 10:40:02.144 INFO blam! test tests::builder::exec_join ... ok
Oct 11 10:40:02.144 INFO blam! test tests::builder::pipeline_capture ... ok
Oct 11 10:40:02.149 INFO blam! test tests::builder::pipeline_stream_out ... ok
Oct 11 10:40:02.163 INFO blam! test tests::builder::pipeline_capture_error ... ok
Oct 11 10:40:02.165 INFO blam! test tests::builder::pipeline_stream_in ... ok
Oct 11 10:40:02.177 INFO blam! test tests::builder::pipeline_compose_pipelines ... ok
Oct 11 10:40:02.193 INFO blam! test tests::builder::stream_capture_err ... ok
Oct 11 10:40:02.193 INFO blam! test tests::builder::stream_capture_out ... ok
Oct 11 10:40:02.193 INFO blam! test tests::builder::pipeline_join ... ok
Oct 11 10:40:02.200 INFO blam! test tests::builder::stream_stderr ... ok
Oct 11 10:40:02.201 INFO blam! test tests::builder::reject_input_data_join ... ok
Oct 11 10:40:02.201 INFO blam! test tests::builder::reject_input_data_popen ... ok
Oct 11 10:40:02.201 INFO blam! test tests::builder::reject_input_data_stream_stderr ... ok
Oct 11 10:40:02.201 INFO blam! test tests::builder::reject_input_data_stream_stdout ... ok
Oct 11 10:40:02.201 INFO blam! test tests::builder::reject_input_data_stream_stdin ... ok
Oct 11 10:40:02.202 INFO blam! test tests::builder::stream_capture_out_with_input_data2 ... ok
Oct 11 10:40:02.208 INFO blam! test tests::common::communicate_input ... ok
Oct 11 10:40:02.208 INFO blam! test tests::common::communicate_input_output ... ok
Oct 11 10:40:02.208 INFO blam! test tests::builder::stream_capture_out_with_input_data1 ... ok
Oct 11 10:40:02.216 INFO blam! test tests::builder::stream_stdout ... ok
Oct 11 10:40:02.216 INFO blam! test tests::common::communicate_output ... ok
Oct 11 10:40:02.216 INFO blam! test tests::common::env_dup ... ok
Oct 11 10:40:02.216 INFO blam! test tests::common::bad_cmd ... ok
Oct 11 10:40:02.220 INFO blam! test tests::common::cwd ... ok
Oct 11 10:40:02.220 INFO blam! test tests::common::good_cmd ... ok
Oct 11 10:40:02.220 INFO blam! test tests::common::env_add ... ok
Oct 11 10:40:02.220 INFO blam! test tests::builder::stream_stdin ... ok
Oct 11 10:40:02.220 INFO blam! test tests::common::err_exit ... ok
Oct 11 10:40:02.224 INFO blam! test tests::common::communicate_input_output_long ... ok
Oct 11 10:40:02.225 INFO blam! test tests::common::null_byte_in_cmd ... ok
Oct 11 10:40:02.225 INFO blam! test tests::common::merge_err_to_out_file ... ok
Oct 11 10:40:02.228 INFO blam! test tests::common::input_from_file ... ok
Oct 11 10:40:02.229 INFO blam! test tests::common::failed_cwd ... ok
Oct 11 10:40:02.229 INFO blam! test tests::common::merge_err_to_out_pipe ... ok
Oct 11 10:40:02.229 INFO blam! test tests::common::output_to_file ... ok
Oct 11 10:40:02.236 INFO blam! test tests::common::reject_empty_argv ... ok
Oct 11 10:40:02.237 INFO blam! test tests::common::read_from_stdout ... ok
Oct 11 10:40:02.237 INFO blam! test tests::common::input_output_from_file ... ok
Oct 11 10:40:02.237 INFO blam! test tests::common::terminate ... ok
Oct 11 10:40:02.237 INFO blam! test tests::common::merge_out_to_err_pipe ... ok
Oct 11 10:40:02.249 INFO blam! test tests::posix::env_set_all_2 ... ok
Oct 11 10:40:02.249 INFO blam! test tests::common::simple_pipe ... ok
Oct 11 10:40:02.249 INFO blam! test tests::posix::err_terminate ... ok
Oct 11 10:40:02.250 INFO blam! test tests::common::setup_executable ... ok
Oct 11 10:40:02.262 INFO blam! test tests::posix::env_set_all_1 ... ok
Oct 11 10:40:02.262 INFO blam! test tests::posix::waitpid_echild ... ok
Oct 11 10:40:02.262 INFO blam! test tests::common::write_to_subprocess ... ok
Oct 11 10:40:02.262 INFO blam! test tests::posix::send_signal ... ok
Oct 11 10:40:02.346 INFO blam! test tests::common::terminate_twice ... ok
Oct 11 10:40:02.770 INFO blam! test tests::common::wait_timeout ... ok
Oct 11 10:40:02.770 INFO blam! 
Oct 11 10:40:02.770 INFO blam! test result: ok. 62 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:02.770 INFO blam! 
Oct 11 10:40:02.772 INFO kablam!      Running /target/debug/deps/just_echo-d9eacc8b7a11c9b2
Oct 11 10:40:02.773 INFO blam! 
Oct 11 10:40:02.773 INFO blam! running 0 tests
Oct 11 10:40:02.773 INFO blam! 
Oct 11 10:40:02.773 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:02.773 INFO blam! 
Oct 11 10:40:02.774 INFO kablam!      Running /target/debug/deps/escape_args-58b8939c7c8423bd
Oct 11 10:40:02.775 INFO blam! 
Oct 11 10:40:02.775 INFO blam! running 1 test
Oct 11 10:40:02.796 INFO blam! test escape_args ... ok
Oct 11 10:40:02.796 INFO kablam!      Running /target/debug/deps/just_echo-6cc442b337e5ebff
Oct 11 10:40:02.796 INFO blam! 
Oct 11 10:40:02.796 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:02.796 INFO blam! 
Oct 11 10:40:02.797 INFO blam! 
Oct 11 10:40:02.797 INFO kablam!      Running /target/debug/deps/weird_args-73ca48aaefb318e8
Oct 11 10:40:02.797 INFO blam! running 0 tests
Oct 11 10:40:02.797 INFO blam! 
Oct 11 10:40:02.797 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:02.797 INFO blam! 
Oct 11 10:40:02.799 INFO blam! 
Oct 11 10:40:02.799 INFO blam! running 1 test
Oct 11 10:40:02.817 INFO blam! test weird_args ... ok
Oct 11 10:40:02.817 INFO kablam!    Doc-tests subprocess
Oct 11 10:40:02.817 INFO blam! 
Oct 11 10:40:02.817 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:02.818 INFO blam! 
Oct 11 10:40:04.013 INFO blam! 
Oct 11 10:40:04.013 INFO blam! running 12 tests
Oct 11 10:40:06.792 INFO blam! test src/builder.rs - builder::exec::Exec (line 43) ... ok
Oct 11 10:40:07.260 INFO blam! test src/builder.rs - builder::pipeline::Pipeline (line 692) ... ok
Oct 11 10:40:07.861 INFO blam! test src/builder.rs - builder::exec::Exec (line 54) ... ok
Oct 11 10:40:08.132 INFO blam! test src/builder.rs - builder::pipeline::Pipeline (line 703) ... ok
Oct 11 10:40:08.148 INFO blam! test src/builder.rs - builder::exec::Exec (line 89) ... ok
Oct 11 10:40:08.208 INFO blam! test src/builder.rs - builder::exec::Exec (line 65) ... ok
Oct 11 10:40:08.237 INFO blam! test src/builder.rs - builder::exec::Exec (line 76) ... ok
Oct 11 10:40:08.440 INFO blam! test src/builder.rs - builder::exec::Exec (line 103) ... ok
Oct 11 10:40:09.204 INFO blam! test src/lib.rs -  (line 53) ... ok
Oct 11 10:40:09.300 INFO blam! test src/lib.rs -  (line 30) ... ok
Oct 11 10:40:09.608 INFO blam! test src/popen.rs - popen::Popen::create (line 335) ... ok
Oct 11 10:40:10.080 INFO kablam! su: No module specific data is present
Oct 11 10:40:10.080 INFO blam! test src/popen.rs - popen::PopenConfig (line 135) ... ok
Oct 11 10:40:10.080 INFO blam! 
Oct 11 10:40:10.080 INFO blam! test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 10:40:10.080 INFO blam! 
Oct 11 10:40:10.612 INFO running `"docker" "rm" "-f" "396dc79430b5b65215e5d6f76f864f6fd7b77c58ad0783e7345e4a6fa73e85ba"`
Oct 11 10:40:10.894 INFO blam! 396dc79430b5b65215e5d6f76f864f6fd7b77c58ad0783e7345e4a6fa73e85ba