Oct 12 01:53:14.533 INFO testing dbg-1.0.4 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling
Oct 12 01:53:14.533 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 01:53:14.873 INFO blam! 71a4246328b3995153f9e008d9d555186da10e3727d4303b61e31a9c86849ac5
Oct 12 01:53:14.875 INFO running `"docker" "start" "-a" "71a4246328b3995153f9e008d9d555186da10e3727d4303b61e31a9c86849ac5"`
Oct 12 01:53:15.814 INFO kablam! usermod: no changes
Oct 12 01:53:15.844 INFO kablam!    Compiling dbg v1.0.4 (/source)
Oct 12 01:53:16.416 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.58s
Oct 12 01:53:16.418 INFO kablam! su: No module specific data is present
Oct 12 01:53:16.774 INFO running `"docker" "rm" "-f" "71a4246328b3995153f9e008d9d555186da10e3727d4303b61e31a9c86849ac5"`
Oct 12 01:53:17.081 INFO blam! 71a4246328b3995153f9e008d9d555186da10e3727d4303b61e31a9c86849ac5
Oct 12 01:53:17.092 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 01:53:17.512 INFO blam! ba888e388e6f0d8ed3587e35d7a24dd39f136b30aacd692e1753aa1ea22e9fc2
Oct 12 01:53:17.512 INFO running `"docker" "start" "-a" "ba888e388e6f0d8ed3587e35d7a24dd39f136b30aacd692e1753aa1ea22e9fc2"`
Oct 12 01:53:18.070 INFO kablam! usermod: no changes
Oct 12 01:53:18.101 INFO kablam!    Compiling dbg v1.0.4 (/source)
Oct 12 01:53:19.708 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.61s
Oct 12 01:53:19.708 INFO kablam! su: No module specific data is present
Oct 12 01:53:20.262 INFO running `"docker" "rm" "-f" "ba888e388e6f0d8ed3587e35d7a24dd39f136b30aacd692e1753aa1ea22e9fc2"`
Oct 12 01:53:20.441 INFO blam! ba888e388e6f0d8ed3587e35d7a24dd39f136b30aacd692e1753aa1ea22e9fc2
Oct 12 01:53:20.448 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 01:53:20.670 INFO blam! ca54ec07f878cd711fd05f1891c1afe78c853b108931a8ce71f1287e0b917722
Oct 12 01:53:20.672 INFO running `"docker" "start" "-a" "ca54ec07f878cd711fd05f1891c1afe78c853b108931a8ce71f1287e0b917722"`
Oct 12 01:53:21.286 INFO kablam! usermod: no changes
Oct 12 01:53:21.340 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Oct 12 01:53:21.342 INFO kablam!      Running /target/debug/deps/dbg-feeea8574e3e452d
Oct 12 01:53:21.345 INFO blam! 
Oct 12 01:53:21.345 INFO blam! running 10 tests
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:287]
Oct 12 01:53:21.346 INFO kablam! => "are we at the base case?" = false
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:287]
Oct 12 01:53:21.346 INFO kablam! => "are we at the base case?" = false
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:287]
Oct 12 01:53:21.346 INFO kablam! => "are we at the base case?" = false
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:287]
Oct 12 01:53:21.346 INFO kablam! => "are we at the base case?" = true
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:288]
Oct 12 01:53:21.346 INFO kablam! => "base value" = 1
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:290]
Oct 12 01:53:21.346 INFO kablam! => "ascending with n * factorial(n - 1)" = 2
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:290]
Oct 12 01:53:21.346 INFO kablam! => "ascending with n * factorial(n - 1)" = 6
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:290]
Oct 12 01:53:21.346 INFO kablam! => "ascending with n * factorial(n - 1)" = 24
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.346 INFO kablam! [DEBUGGING, src/lib.rs:294]
Oct 12 01:53:21.346 INFO kablam! => factorial(4) = 24
Oct 12 01:53:21.346 INFO kablam! 
Oct 12 01:53:21.352 INFO blam! test tests::factorial_labels ... ok
Oct 12 01:53:21.364 INFO kablam! [DEBUGGING, src/lib.rs:234]
Oct 12 01:53:21.364 INFO kablam! => Point{x: 1, y: 2,} = Point {
Oct 12 01:53:21.364 INFO kablam!     x: 1,
Oct 12 01:53:21.364 INFO kablam!     y: 2
Oct 12 01:53:21.364 INFO kablam! }
Oct 12 01:53:21.364 INFO kablam! 
Oct 12 01:53:21.364 INFO kablam! [DEBUGGING, src/lib.rs:237]
Oct 12 01:53:21.364 INFO kablam! => p = Point {
Oct 12 01:53:21.364 INFO kablam!     x: 4,
Oct 12 01:53:21.364 INFO kablam!     y: 5
Oct 12 01:53:21.364 INFO kablam! }
Oct 12 01:53:21.364 INFO kablam! 
Oct 12 01:53:21.384 INFO blam! test tests::common_use ... ok
Oct 12 01:53:21.385 INFO kablam! [DEBUGGING, src/lib.rs:299]
Oct 12 01:53:21.385 INFO kablam! => n = 4, n <= 1 = false
Oct 12 01:53:21.385 INFO kablam! 
Oct 12 01:53:21.385 INFO kablam! [DEBUGGING, src/lib.rs:299]
Oct 12 01:53:21.385 INFO kablam! => n = 3, n <= 1 = false
Oct 12 01:53:21.385 INFO kablam! 
Oct 12 01:53:21.392 INFO kablam! [DEBUGGING, src/lib.rs:299]
Oct 12 01:53:21.392 INFO kablam! => n = 2, n <= 1 = false
Oct 12 01:53:21.392 INFO kablam! 
Oct 12 01:53:21.392 INFO kablam! [DEBUGGING, src/lib.rs:299]
Oct 12 01:53:21.392 INFO kablam! => n = 1, n <= 1 = true
Oct 12 01:53:21.392 INFO kablam! 
Oct 12 01:53:21.392 INFO kablam! [DEBUGGING, src/lib.rs:300]
Oct 12 01:53:21.393 INFO kablam! => n = 1, 1 = 1
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:302]
Oct 12 01:53:21.393 INFO kablam! => n = 2, n * factorial(n - 1) = 2
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:302]
Oct 12 01:53:21.393 INFO kablam! => n = 3, n * factorial(n - 1) = 6
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:302]
Oct 12 01:53:21.393 INFO kablam! => n = 4, n * factorial(n - 1) = 24
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:306]
Oct 12 01:53:21.393 INFO kablam! => factorial(4) = 24
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:261]
Oct 12 01:53:21.393 INFO kablam! => "width" = 1, "height" = 2, "area" = 2
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:264]
Oct 12 01:53:21.393 INFO kablam! => "first point" = Point {
Oct 12 01:53:21.393 INFO kablam!     x: 4,
Oct 12 01:53:21.393 INFO kablam!     y: 5
Oct 12 01:53:21.393 INFO kablam! }, "same point" = Point {
Oct 12 01:53:21.393 INFO kablam!     x: 4,
Oct 12 01:53:21.393 INFO kablam!     y: 5
Oct 12 01:53:21.393 INFO kablam! }
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:275]
Oct 12 01:53:21.393 INFO kablam! => n <= 1 = false
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:275]
Oct 12 01:53:21.393 INFO kablam! => n <= 1 = false
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:275]
Oct 12 01:53:21.393 INFO kablam! => n <= 1 = false
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:275]
Oct 12 01:53:21.393 INFO kablam! => n <= 1 = true
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:276]
Oct 12 01:53:21.393 INFO kablam! => 1 = 1
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:278]
Oct 12 01:53:21.393 INFO kablam! => n * factorial(n - 1) = 2
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:278]
Oct 12 01:53:21.393 INFO kablam! => n * factorial(n - 1) = 6
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:278]
Oct 12 01:53:21.393 INFO kablam! => n * factorial(n - 1) = 24
Oct 12 01:53:21.393 INFO kablam! 
Oct 12 01:53:21.393 INFO kablam! [DEBUGGING, src/lib.rs:282]
Oct 12 01:53:21.394 INFO kablam! => factorial(4) = 24
Oct 12 01:53:21.394 INFO kablam! 
Oct 12 01:53:21.394 INFO kablam! [DEBUGGING, src/lib.rs:270]
Oct 12 01:53:21.394 INFO kablam! => &a = [<unknown> of type &tests::not_debug::X is !Debug]
Oct 12 01:53:21.394 INFO kablam! 
Oct 12 01:53:21.394 INFO blam! test tests::factorial_multiarg ... ok
Oct 12 01:53:21.394 INFO blam! test tests::labels ... ok
Oct 12 01:53:21.394 INFO blam! test tests::factorial_simple ... ok
Oct 12 01:53:21.395 INFO blam! test tests::not_debug ... ok
Oct 12 01:53:21.452 INFO blam! test tests::panics ... ok
Oct 12 01:53:21.452 INFO blam! test tests::types ... ok
Oct 12 01:53:21.452 INFO kablam! [DEBUGGING, src/lib.rs:314]
Oct 12 01:53:21.452 INFO kablam! => a = 1, panic!() = [DEBUGGING, src/lib.rs:249]
Oct 12 01:53:21.452 INFO kablam! => a = 1
Oct 12 01:53:21.452 INFO kablam! 
Oct 12 01:53:21.452 INFO kablam! [DEBUGGING, src/lib.rs:250]
Oct 12 01:53:21.452 INFO kablam! => a = 1, b = 2
Oct 12 01:53:21.452 INFO kablam! 
Oct 12 01:53:21.452 INFO kablam! [DEBUGGING, src/lib.rs:251]
Oct 12 01:53:21.452 INFO kablam! => a = 1, b = 2, a + b = 3
Oct 12 01:53:21.452 INFO kablam! 
Oct 12 01:53:21.452 INFO kablam! [DEBUGGING, src/lib.rs:255]
Oct 12 01:53:21.452 INFO kablam! => &p = Point {
Oct 12 01:53:21.452 INFO kablam!     x: 4,
Oct 12 01:53:21.452 INFO kablam!     y: 5
Oct 12 01:53:21.452 INFO kablam! }, &q = Point {
Oct 12 01:53:21.452 INFO kablam!     x: 2,
Oct 12 01:53:21.452 INFO kablam!     y: 1
Oct 12 01:53:21.452 INFO kablam! }
Oct 12 01:53:21.452 INFO kablam! 
Oct 12 01:53:21.453 INFO kablam! [DEBUGGING, src/lib.rs:230]
Oct 12 01:53:21.453 INFO blam! test tests::unit_works ... ok
Oct 12 01:53:21.453 INFO kablam! => () = ()
Oct 12 01:53:21.453 INFO kablam! 
Oct 12 01:53:21.453 INFO kablam! [DEBUGGING, src/lib.rs:241]
Oct 12 01:53:21.453 INFO kablam! => 1 + 2 = 3
Oct 12 01:53:21.453 INFO kablam! 
Oct 12 01:53:21.453 INFO kablam! [DEBUGGING, src/lib.rs:242]
Oct 12 01:53:21.453 INFO kablam! => x + 1 = 4
Oct 12 01:53:21.453 INFO kablam! 
Oct 12 01:53:21.453 INFO kablam! [DEBUGGING, src/lib.rs:242]
Oct 12 01:53:21.453 INFO kablam! => 3 = 3
Oct 12 01:53:21.453 INFO kablam! 
Oct 12 01:53:21.453 INFO kablam! [DEBUGGING, src/lib.rs:243]
Oct 12 01:53:21.453 INFO kablam! => y = 7
Oct 12 01:53:21.453 INFO kablam! 
Oct 12 01:53:21.456 INFO blam! test tests::passthrough ... ok
Oct 12 01:53:21.456 INFO kablam!    Doc-tests dbg
Oct 12 01:53:21.456 INFO blam! 
Oct 12 01:53:21.456 INFO blam! test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:53:21.456 INFO blam! 
Oct 12 01:53:21.637 INFO blam! 
Oct 12 01:53:21.637 INFO blam! running 0 tests
Oct 12 01:53:21.637 INFO blam! 
Oct 12 01:53:21.637 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:53:21.637 INFO blam! 
Oct 12 01:53:21.644 INFO kablam! su: No module specific data is present
Oct 12 01:53:22.044 INFO running `"docker" "rm" "-f" "ca54ec07f878cd711fd05f1891c1afe78c853b108931a8ce71f1287e0b917722"`
Oct 12 01:53:22.219 INFO blam! ca54ec07f878cd711fd05f1891c1afe78c853b108931a8ce71f1287e0b917722