Oct 11 16:00:37.359 INFO testing npm_scripts-0.1.2 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 16:00:37.359 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 16:00:37.359 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 16:00:37.647 INFO blam! 3e29a6431df2dd6cad92fd8d78ba7e96343287d9738c412abe4a755360407e59
Oct 11 16:00:37.648 INFO running `"docker" "start" "-a" "3e29a6431df2dd6cad92fd8d78ba7e96343287d9738c412abe4a755360407e59"`
Oct 11 16:00:38.331 INFO kablam! usermod: no changes
Oct 11 16:00:38.436 INFO kablam!    Compiling npm_scripts v0.1.2 (/source)
Oct 11 16:00:40.477 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2.12s
Oct 11 16:00:40.481 INFO kablam! su: No module specific data is present
Oct 11 16:00:42.196 INFO running `"docker" "rm" "-f" "3e29a6431df2dd6cad92fd8d78ba7e96343287d9738c412abe4a755360407e59"`
Oct 11 16:00:42.302 INFO blam! 3e29a6431df2dd6cad92fd8d78ba7e96343287d9738c412abe4a755360407e59
Oct 11 16:00:42.305 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 16:00:42.305 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 16:00:42.583 INFO blam! 8a8c6c2bb665943112243f6effb292f87875ba4e3f501209ef61530173df6086
Oct 11 16:00:42.585 INFO running `"docker" "start" "-a" "8a8c6c2bb665943112243f6effb292f87875ba4e3f501209ef61530173df6086"`
Oct 11 16:00:43.004 INFO kablam! usermod: no changes
Oct 11 16:00:43.085 INFO kablam!    Compiling npm_scripts v0.1.2 (/source)
Oct 11 16:00:45.954 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2.92s
Oct 11 16:00:45.958 INFO kablam! su: No module specific data is present
Oct 11 16:00:46.269 INFO running `"docker" "rm" "-f" "8a8c6c2bb665943112243f6effb292f87875ba4e3f501209ef61530173df6086"`
Oct 11 16:00:46.331 INFO blam! 8a8c6c2bb665943112243f6effb292f87875ba4e3f501209ef61530173df6086
Oct 11 16:00:46.332 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 16:00:46.333 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 16:00:46.527 INFO blam! e981728d7380b93eead6c0a5992648d61f57b8c982ff5588e87d7ed0dc4d08ea
Oct 11 16:00:46.529 INFO running `"docker" "start" "-a" "e981728d7380b93eead6c0a5992648d61f57b8c982ff5588e87d7ed0dc4d08ea"`
Oct 11 16:00:47.000 INFO kablam! usermod: no changes
Oct 11 16:00:47.062 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Oct 11 16:00:47.062 INFO kablam!      Running /target/debug/deps/npm_scripts-932f599c965f6a59
Oct 11 16:00:47.066 INFO blam! 
Oct 11 16:00:47.066 INFO blam! running 7 tests
Oct 11 16:00:47.067 INFO blam! test tests::it_detects_package_json_availability ... ok
Oct 11 16:00:47.074 INFO blam! test tests::test_package_does_not_have_script ... ok
Oct 11 16:00:47.076 INFO blam! test tests::it_detects_package_json_absence ... ok
Oct 11 16:00:47.084 INFO blam! test tests::it_detects_missing_package_json ... ok
Oct 11 16:00:47.085 INFO blam! test tests::test_package_has_script ... ok
Oct 11 16:00:47.097 INFO blam! test tests::it_installs_dependencies ... FAILED
Oct 11 16:00:47.097 INFO blam! test tests::test_running_a_script ... FAILED
Oct 11 16:00:47.097 INFO blam! 
Oct 11 16:00:47.097 INFO blam! failures:
Oct 11 16:00:47.099 INFO blam! 
Oct 11 16:00:47.099 INFO blam! ---- tests::it_installs_dependencies stdout ----
Oct 11 16:00:47.099 INFO blam! thread 'tests::it_installs_dependencies' panicked at 'assertion failed: res.is_ok()', src/lib.rs:142:9
Oct 11 16:00:47.099 INFO blam! stack backtrace:
Oct 11 16:00:47.099 INFO blam!    0:     0x5577f7fccefe - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617
Oct 11 16:00:47.099 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 11 16:00:47.099 INFO blam!    1:     0x5577f7fd9486 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9
Oct 11 16:00:47.099 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Oct 11 16:00:47.099 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Oct 11 16:00:47.099 INFO blam!    2:     0x5577f7fd218d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:211
Oct 11 16:00:47.099 INFO blam!    3:     0x5577f7fd1e9b - std::panicking::default_hook::h1ef46fa7cd894809
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:221
Oct 11 16:00:47.099 INFO blam!    4:     0x5577f7fd283c - std::panicking::rust_panic_with_hook::h05510fde8841c579
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:476
Oct 11 16:00:47.099 INFO blam!    5:     0x5577f7f90c6f - std::panicking::begin_panic::hcf3c4614edcf2743
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:410
Oct 11 16:00:47.099 INFO blam!    6:     0x5577f7f48c82 - npm_scripts::tests::it_installs_dependencies::h933d61b714f290b7
Oct 11 16:00:47.099 INFO blam!                                at src/lib.rs:142
Oct 11 16:00:47.099 INFO blam!    7:     0x5577f7f48bc9 - npm_scripts::tests::it_installs_dependencies::{{closure}}::hf2bf6bdd27ff652d
Oct 11 16:00:47.099 INFO blam!                                at src/lib.rs:137
Oct 11 16:00:47.099 INFO blam!    8:     0x5577f7f46c5d - core::ops::function::FnOnce::call_once::hb8d938462c0599c6
Oct 11 16:00:47.099 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:00:47.099 INFO blam!    9:     0x5577f7f4a61e - <F as alloc::boxed::FnBox<A>>::call_box::h95b7cb918af67b5d
Oct 11 16:00:47.099 INFO blam!                                at libtest/lib.rs:1468
Oct 11 16:00:47.099 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:00:47.099 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:00:47.099 INFO blam!   10:     0x5577f7fe4659 - __rust_maybe_catch_panic
Oct 11 16:00:47.099 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:00:47.099 INFO blam!   11:     0x5577f7f6b16d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:00:47.099 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:00:47.099 INFO blam!                                at libtest/lib.rs:1423
Oct 11 16:00:47.099 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Oct 11 16:00:47.099 INFO blam!   12:     0x5577f7f6bd74 - std::panicking::try::do_call::ha990a345054c2d63
Oct 11 16:00:47.099 INFO blam!                                at libstd/thread/mod.rs:409
Oct 11 16:00:47.099 INFO blam!                                at libstd/panic.rs:313
Oct 11 16:00:47.099 INFO blam!                                at libstd/panicking.rs:310
Oct 11 16:00:47.099 INFO blam!   13:     0x5577f7fe4659 - __rust_maybe_catch_panic
Oct 11 16:00:47.099 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:00:47.099 INFO blam!   14:     0x5577f7f59336 - <F as alloc::boxed::FnBox<A>>::call_box::h96125cb29a9ba44b
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:00:47.100 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:00:47.100 INFO blam!                                at libstd/thread/mod.rs:408
Oct 11 16:00:47.100 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:00:47.100 INFO blam!   15:     0x5577f7fcf84a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1
Oct 11 16:00:47.100 INFO blam!                                at liballoc/boxed.rs:682
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys_common/thread.rs:24
Oct 11 16:00:47.100 INFO blam!   16:     0x5577f7fc27e5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys/unix/thread.rs:90
Oct 11 16:00:47.100 INFO blam!   17:     0x7f49227606b9 - start_thread
Oct 11 16:00:47.100 INFO blam!   18:     0x7f492228041c - clone
Oct 11 16:00:47.100 INFO blam!   19:                0x0 - <unknown>
Oct 11 16:00:47.100 INFO blam! 
Oct 11 16:00:47.100 INFO blam! ---- tests::test_running_a_script stdout ----
Oct 11 16:00:47.100 INFO blam! thread 'tests::test_running_a_script' panicked at 'assertion failed: res.is_ok()', src/lib.rs:133:9
Oct 11 16:00:47.100 INFO blam! stack backtrace:
Oct 11 16:00:47.100 INFO blam!    0:     0x5577f7fccefe - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 11 16:00:47.100 INFO blam!    1:     0x5577f7fd9486 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Oct 11 16:00:47.100 INFO blam!    2:     0x5577f7fd218d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:211
Oct 11 16:00:47.100 INFO blam!    3:     0x5577f7fd1e9b - std::panicking::default_hook::h1ef46fa7cd894809
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:221
Oct 11 16:00:47.100 INFO blam!    4:     0x5577f7fd283c - std::panicking::rust_panic_with_hook::h05510fde8841c579
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:476
Oct 11 16:00:47.100 INFO blam!    5:     0x5577f7f90c6f - std::panicking::begin_panic::hcf3c4614edcf2743
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:410
Oct 11 16:00:47.100 INFO blam!    6:     0x5577f7f48b7e - npm_scripts::tests::test_running_a_script::h3e9db8dc0502d4a1
Oct 11 16:00:47.100 INFO blam!                                at src/lib.rs:133
Oct 11 16:00:47.100 INFO blam!    7:     0x5577f7f48ab9 - npm_scripts::tests::test_running_a_script::{{closure}}::h7aa4f68484d3a564
Oct 11 16:00:47.100 INFO blam!                                at src/lib.rs:129
Oct 11 16:00:47.100 INFO blam!    8:     0x5577f7f46b2d - core::ops::function::FnOnce::call_once::h4754e23ee2e1d8be
Oct 11 16:00:47.100 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:00:47.100 INFO blam!    9:     0x5577f7f4a61e - <F as alloc::boxed::FnBox<A>>::call_box::h95b7cb918af67b5d
Oct 11 16:00:47.100 INFO blam!                                at libtest/lib.rs:1468
Oct 11 16:00:47.100 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:00:47.100 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:00:47.100 INFO blam!   10:     0x5577f7fe4659 - __rust_maybe_catch_panic
Oct 11 16:00:47.100 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:00:47.100 INFO blam!   11:     0x5577f7f6b16d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:00:47.100 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:00:47.100 INFO blam!                                at libtest/lib.rs:1423
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Oct 11 16:00:47.100 INFO blam!   12:     0x5577f7f6bd74 - std::panicking::try::do_call::ha990a345054c2d63
Oct 11 16:00:47.100 INFO blam!                                at libstd/thread/mod.rs:409
Oct 11 16:00:47.100 INFO blam!                                at libstd/panic.rs:313
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:310
Oct 11 16:00:47.100 INFO blam!   13:     0x5577f7fe4659 - __rust_maybe_catch_panic
Oct 11 16:00:47.100 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:00:47.100 INFO blam!   14:     0x5577f7f59336 - <F as alloc::boxed::FnBox<A>>::call_box::h96125cb29a9ba44b
Oct 11 16:00:47.100 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:00:47.100 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:00:47.100 INFO blam!                                at libstd/thread/mod.rs:408
Oct 11 16:00:47.100 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:00:47.100 INFO blam!   15:     0x5577f7fcf84a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1
Oct 11 16:00:47.100 INFO blam!                                at liballoc/boxed.rs:682
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys_common/thread.rs:24
Oct 11 16:00:47.100 INFO blam!   16:     0x5577f7fc27e5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886
Oct 11 16:00:47.100 INFO blam!                                at libstd/sys/unix/thread.rs:90
Oct 11 16:00:47.100 INFO blam!   17:     0x7f49227606b9 - start_thread
Oct 11 16:00:47.100 INFO blam!   18:     0x7f492228041c - clone
Oct 11 16:00:47.100 INFO blam!   19:                0x0 - <unknown>
Oct 11 16:00:47.100 INFO blam! 
Oct 11 16:00:47.100 INFO blam! 
Oct 11 16:00:47.100 INFO blam! failures:
Oct 11 16:00:47.100 INFO blam!     tests::it_installs_dependencies
Oct 11 16:00:47.100 INFO blam!     tests::test_running_a_script
Oct 11 16:00:47.100 INFO blam! 
Oct 11 16:00:47.100 INFO blam! test result: FAILED. 5 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 16:00:47.100 INFO blam! 
Oct 11 16:00:47.101 INFO kablam! error: test failed, to rerun pass '--lib'
Oct 11 16:00:47.101 INFO kablam! su: No module specific data is present
Oct 11 16:00:47.393 INFO running `"docker" "rm" "-f" "e981728d7380b93eead6c0a5992648d61f57b8c982ff5588e87d7ed0dc4d08ea"`
Oct 11 16:00:47.467 INFO blam! e981728d7380b93eead6c0a5992648d61f57b8c982ff5588e87d7ed0dc4d08ea