Oct 11 13:31:32.572 INFO testing rlog-1.0.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 11 13:31:32.572 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 11 13:31:32.572 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 13:31:32.805 INFO blam! d590c3de924a586d7b130a73d178dd62491da951e855ddb104b3fcd1bbd9eb7f Oct 11 13:31:32.806 INFO running `"docker" "start" "-a" "d590c3de924a586d7b130a73d178dd62491da951e855ddb104b3fcd1bbd9eb7f"` Oct 11 13:31:33.336 INFO kablam! usermod: no changes Oct 11 13:31:33.398 INFO kablam! Compiling rlog v1.0.0 (/source) Oct 11 13:31:34.767 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1.41s Oct 11 13:31:34.770 INFO kablam! su: No module specific data is present Oct 11 13:31:35.030 INFO running `"docker" "rm" "-f" "d590c3de924a586d7b130a73d178dd62491da951e855ddb104b3fcd1bbd9eb7f"` Oct 11 13:31:35.156 INFO blam! d590c3de924a586d7b130a73d178dd62491da951e855ddb104b3fcd1bbd9eb7f Oct 11 13:31:35.158 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 11 13:31:35.158 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 13:31:35.376 INFO blam! f826c6d1efa0cb17917070646ce5b1fb27540efcc472915c8878ea1ac49a23f2 Oct 11 13:31:35.380 INFO running `"docker" "start" "-a" "f826c6d1efa0cb17917070646ce5b1fb27540efcc472915c8878ea1ac49a23f2"` Oct 11 13:31:35.844 INFO kablam! usermod: no changes Oct 11 13:31:35.885 INFO kablam! Compiling rlog v1.0.0 (/source) Oct 11 13:31:38.313 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 2.45s Oct 11 13:31:38.320 INFO kablam! su: No module specific data is present Oct 11 13:31:38.680 INFO running `"docker" "rm" "-f" "f826c6d1efa0cb17917070646ce5b1fb27540efcc472915c8878ea1ac49a23f2"` Oct 11 13:31:38.794 INFO blam! f826c6d1efa0cb17917070646ce5b1fb27540efcc472915c8878ea1ac49a23f2 Oct 11 13:31:38.797 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 11 13:31:38.797 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 13:31:39.056 INFO blam! dbcffb3b39187e7743bfa0538991cd3ea88b587d61db2f170dd760f2251d7168 Oct 11 13:31:39.059 INFO running `"docker" "start" "-a" "dbcffb3b39187e7743bfa0538991cd3ea88b587d61db2f170dd760f2251d7168"` Oct 11 13:31:39.562 INFO kablam! usermod: no changes Oct 11 13:31:39.614 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.02s Oct 11 13:31:39.640 INFO kablam! Running /target/debug/deps/rlog-c46b1a1dccf458df Oct 11 13:31:39.643 INFO blam! Oct 11 13:31:39.643 INFO blam! running 0 tests Oct 11 13:31:39.643 INFO blam! Oct 11 13:31:39.643 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 13:31:39.643 INFO blam! Oct 11 13:31:39.644 INFO kablam! Running /target/debug/deps/tests-d33853b32346abe0 Oct 11 13:31:39.646 INFO blam! Oct 11 13:31:39.646 INFO blam! running 9 tests Oct 11 13:31:39.652 INFO blam! test instantiate ... ok Oct 11 13:31:39.656 INFO blam! test test_get_fmt ... ok Oct 11 13:31:39.658 INFO blam! test bad_file_name ... ok Oct 11 13:31:39.659 INFO blam! test test_get_path ... ok Oct 11 13:31:39.668 INFO blam! test logging_str ... FAILED Oct 11 13:31:39.668 INFO blam! test logging_reverse_format ... FAILED Oct 11 13:31:39.668 INFO blam! test empty_format ... FAILED Oct 11 13:31:39.668 INFO blam! test custom_format ... FAILED Oct 11 13:31:39.668 INFO blam! test logging_string ... FAILED Oct 11 13:31:39.668 INFO blam! Oct 11 13:31:39.668 INFO blam! failures: Oct 11 13:31:39.669 INFO blam! Oct 11 13:31:39.669 INFO blam! ---- logging_str stdout ---- Oct 11 13:31:39.669 INFO blam! Logger::log() open error: Oct 11 13:31:39.669 INFO blam! Read-only file system (os error 30) Oct 11 13:31:39.669 INFO blam! Oct 11 13:31:39.669 INFO blam! thread 'logging_str' panicked at 'assertion failed: log.log("logging_str()")', tests/tests.rs:36:5 Oct 11 13:31:39.669 INFO blam! stack backtrace: Oct 11 13:31:39.669 INFO blam! 0: 0x56405136317e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 13:31:39.669 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 13:31:39.669 INFO blam! 1: 0x56405136c026 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 13:31:39.669 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 13:31:39.669 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 13:31:39.669 INFO blam! 2: 0x564051366d7d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 13:31:39.669 INFO blam! at libstd/panicking.rs:211 Oct 11 13:31:39.669 INFO blam! 3: 0x564051366a8b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 13:31:39.669 INFO blam! at libstd/panicking.rs:221 Oct 11 13:31:39.670 INFO blam! 4: 0x56405136742c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:476 Oct 11 13:31:39.670 INFO blam! 5: 0x5640513532ef - std::panicking::begin_panic::h115170853f476d93 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:410 Oct 11 13:31:39.670 INFO blam! 6: 0x5640512f5ae1 - tests::logging_str::hffb5e71aaaa89cfa Oct 11 13:31:39.670 INFO blam! at tests/tests.rs:36 Oct 11 13:31:39.670 INFO blam! 7: 0x5640512f5a39 - tests::logging_str::{{closure}}::h6688c1b3d137421a Oct 11 13:31:39.670 INFO blam! at tests/tests.rs:33 Oct 11 13:31:39.670 INFO blam! 8: 0x5640512f76bd - core::ops::function::FnOnce::call_once::hf2b81260023d3637 Oct 11 13:31:39.670 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.670 INFO blam! 9: 0x5640512fb5ce - >::call_box::h95b7cb918af67b5d Oct 11 13:31:39.670 INFO blam! at libtest/lib.rs:1468 Oct 11 13:31:39.670 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.670 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.670 INFO blam! 10: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.670 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.670 INFO blam! 11: 0x56405131c11d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.670 INFO blam! at libtest/lib.rs:1423 Oct 11 13:31:39.670 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 13:31:39.670 INFO blam! 12: 0x56405131cd24 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 13:31:39.670 INFO blam! at libstd/thread/mod.rs:409 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:313 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:310 Oct 11 13:31:39.670 INFO blam! 13: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.670 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.670 INFO blam! 14: 0x56405130a2e6 - >::call_box::h96125cb29a9ba44b Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.670 INFO blam! at libstd/thread/mod.rs:408 Oct 11 13:31:39.670 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.670 INFO blam! 15: 0x5640513651ba - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 13:31:39.670 INFO blam! at liballoc/boxed.rs:682 Oct 11 13:31:39.670 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 13:31:39.670 INFO blam! 16: 0x56405135a935 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 13:31:39.670 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 13:31:39.670 INFO blam! 17: 0x7fc8c90246b9 - start_thread Oct 11 13:31:39.670 INFO blam! 18: 0x7fc8c8b4441c - clone Oct 11 13:31:39.670 INFO blam! 19: 0x0 - Oct 11 13:31:39.670 INFO blam! Oct 11 13:31:39.670 INFO blam! ---- logging_reverse_format stdout ---- Oct 11 13:31:39.670 INFO blam! Logger::log() open error: Oct 11 13:31:39.670 INFO blam! Read-only file system (os error 30) Oct 11 13:31:39.670 INFO blam! Oct 11 13:31:39.670 INFO blam! thread 'logging_reverse_format' panicked at 'assertion failed: log.log("logging_reverse_format()")', tests/tests.rs:62:5 Oct 11 13:31:39.670 INFO blam! stack backtrace: Oct 11 13:31:39.670 INFO blam! 0: 0x56405136317e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 13:31:39.670 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 13:31:39.670 INFO blam! 1: 0x56405136c026 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 13:31:39.670 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 13:31:39.670 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 13:31:39.670 INFO blam! 2: 0x564051366d7d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:211 Oct 11 13:31:39.670 INFO blam! 3: 0x564051366a8b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:221 Oct 11 13:31:39.670 INFO blam! 4: 0x56405136742c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:476 Oct 11 13:31:39.670 INFO blam! 5: 0x5640513532ef - std::panicking::begin_panic::h115170853f476d93 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:410 Oct 11 13:31:39.670 INFO blam! 6: 0x5640512f5da1 - tests::logging_reverse_format::h3259430cdce42cbe Oct 11 13:31:39.670 INFO blam! at tests/tests.rs:62 Oct 11 13:31:39.670 INFO blam! 7: 0x5640512f5cf9 - tests::logging_reverse_format::{{closure}}::h9c11e81ab2f57347 Oct 11 13:31:39.670 INFO blam! at tests/tests.rs:59 Oct 11 13:31:39.670 INFO blam! 8: 0x5640512f757d - core::ops::function::FnOnce::call_once::h5f8bcefe108c4728 Oct 11 13:31:39.670 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.670 INFO blam! 9: 0x5640512fb5ce - >::call_box::h95b7cb918af67b5d Oct 11 13:31:39.670 INFO blam! at libtest/lib.rs:1468 Oct 11 13:31:39.670 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.670 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.670 INFO blam! 10: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.670 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.670 INFO blam! 11: 0x56405131c11d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.670 INFO blam! at libtest/lib.rs:1423 Oct 11 13:31:39.670 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 13:31:39.670 INFO blam! 12: 0x56405131cd24 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 13:31:39.670 INFO blam! at libstd/thread/mod.rs:409 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:313 Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:310 Oct 11 13:31:39.670 INFO blam! 13: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.670 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.670 INFO blam! 14: 0x56405130a2e6 - >::call_box::h96125cb29a9ba44b Oct 11 13:31:39.670 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.670 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.670 INFO blam! at libstd/thread/mod.rs:408 Oct 11 13:31:39.671 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.671 INFO blam! 15: 0x5640513651ba - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 13:31:39.671 INFO blam! at liballoc/boxed.rs:682 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 13:31:39.671 INFO blam! 16: 0x56405135a935 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 13:31:39.671 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 13:31:39.671 INFO blam! 17: 0x7fc8c90246b9 - start_thread Oct 11 13:31:39.671 INFO blam! 18: 0x7fc8c8b4441c - clone Oct 11 13:31:39.671 INFO blam! 19: 0x0 - Oct 11 13:31:39.671 INFO blam! Oct 11 13:31:39.671 INFO blam! ---- empty_format stdout ---- Oct 11 13:31:39.671 INFO blam! Logger::log() open error: Oct 11 13:31:39.671 INFO blam! Read-only file system (os error 30) Oct 11 13:31:39.671 INFO blam! Oct 11 13:31:39.671 INFO blam! thread 'empty_format' panicked at 'assertion failed: log.log("empty_format()")', tests/tests.rs:82:5 Oct 11 13:31:39.671 INFO blam! stack backtrace: Oct 11 13:31:39.671 INFO blam! 0: 0x56405136317e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 13:31:39.671 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 13:31:39.671 INFO blam! 1: 0x56405136c026 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 13:31:39.671 INFO blam! 2: 0x564051366d7d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:211 Oct 11 13:31:39.671 INFO blam! 3: 0x564051366a8b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:221 Oct 11 13:31:39.671 INFO blam! 4: 0x56405136742c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:476 Oct 11 13:31:39.671 INFO blam! 5: 0x5640513532ef - std::panicking::begin_panic::h115170853f476d93 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:410 Oct 11 13:31:39.671 INFO blam! 6: 0x5640512f5f94 - tests::empty_format::h69a613e390941363 Oct 11 13:31:39.671 INFO blam! at tests/tests.rs:82 Oct 11 13:31:39.671 INFO blam! 7: 0x5640512f5ef9 - tests::empty_format::{{closure}}::h6ee35066cd344826 Oct 11 13:31:39.671 INFO blam! at tests/tests.rs:79 Oct 11 13:31:39.671 INFO blam! 8: 0x5640512f75bd - core::ops::function::FnOnce::call_once::h7d1fdd0553409bd5 Oct 11 13:31:39.671 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.671 INFO blam! 9: 0x5640512fb5ce - >::call_box::h95b7cb918af67b5d Oct 11 13:31:39.671 INFO blam! at libtest/lib.rs:1468 Oct 11 13:31:39.671 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.671 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.671 INFO blam! 10: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.671 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.671 INFO blam! 11: 0x56405131c11d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.671 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.671 INFO blam! at libtest/lib.rs:1423 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 13:31:39.671 INFO blam! 12: 0x56405131cd24 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 13:31:39.671 INFO blam! at libstd/thread/mod.rs:409 Oct 11 13:31:39.671 INFO blam! at libstd/panic.rs:313 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:310 Oct 11 13:31:39.671 INFO blam! 13: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.671 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.671 INFO blam! 14: 0x56405130a2e6 - >::call_box::h96125cb29a9ba44b Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.671 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.671 INFO blam! at libstd/thread/mod.rs:408 Oct 11 13:31:39.671 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.671 INFO blam! 15: 0x5640513651ba - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 13:31:39.671 INFO blam! at liballoc/boxed.rs:682 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 13:31:39.671 INFO blam! 16: 0x56405135a935 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 13:31:39.671 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 13:31:39.671 INFO blam! 17: 0x7fc8c90246b9 - start_thread Oct 11 13:31:39.671 INFO blam! 18: 0x7fc8c8b4441c - clone Oct 11 13:31:39.671 INFO blam! 19: 0x0 - Oct 11 13:31:39.671 INFO blam! Oct 11 13:31:39.671 INFO blam! ---- custom_format stdout ---- Oct 11 13:31:39.671 INFO blam! Logger::log() open error: Oct 11 13:31:39.671 INFO blam! Read-only file system (os error 30) Oct 11 13:31:39.671 INFO blam! Oct 11 13:31:39.671 INFO blam! thread 'custom_format' panicked at 'assertion failed: log.log("custom_format()")', tests/tests.rs:95:5 Oct 11 13:31:39.671 INFO blam! stack backtrace: Oct 11 13:31:39.671 INFO blam! 0: 0x56405136317e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 13:31:39.671 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 13:31:39.671 INFO blam! 1: 0x56405136c026 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 13:31:39.671 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 13:31:39.671 INFO blam! 2: 0x564051366d7d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:211 Oct 11 13:31:39.671 INFO blam! 3: 0x564051366a8b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:221 Oct 11 13:31:39.671 INFO blam! 4: 0x56405136742c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:476 Oct 11 13:31:39.671 INFO blam! 5: 0x5640513532ef - std::panicking::begin_panic::h115170853f476d93 Oct 11 13:31:39.671 INFO blam! at libstd/panicking.rs:410 Oct 11 13:31:39.671 INFO blam! 6: 0x5640512f60c1 - tests::custom_format::h5490311fe7721097 Oct 11 13:31:39.671 INFO blam! at tests/tests.rs:95 Oct 11 13:31:39.672 INFO blam! 7: 0x5640512f6019 - tests::custom_format::{{closure}}::hee52e1ae44388857 Oct 11 13:31:39.672 INFO blam! at tests/tests.rs:92 Oct 11 13:31:39.672 INFO blam! 8: 0x5640512f763d - core::ops::function::FnOnce::call_once::hd12c115a7bfad8f9 Oct 11 13:31:39.672 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.672 INFO blam! 9: 0x5640512fb5ce - >::call_box::h95b7cb918af67b5d Oct 11 13:31:39.672 INFO blam! at libtest/lib.rs:1468 Oct 11 13:31:39.672 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.672 INFO blam! 10: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.672 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.672 INFO blam! 11: 0x56405131c11d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.672 INFO blam! at libtest/lib.rs:1423 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 13:31:39.672 INFO blam! 12: 0x56405131cd24 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 13:31:39.672 INFO blam! at libstd/thread/mod.rs:409 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:313 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:310 Oct 11 13:31:39.672 INFO blam! 13: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.672 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.672 INFO blam! 14: 0x56405130a2e6 - >::call_box::h96125cb29a9ba44b Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.672 INFO blam! at libstd/thread/mod.rs:408 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.672 INFO blam! 15: 0x5640513651ba - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:682 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 13:31:39.672 INFO blam! 16: 0x56405135a935 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 13:31:39.672 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 13:31:39.672 INFO blam! 17: 0x7fc8c90246b9 - start_thread Oct 11 13:31:39.672 INFO blam! 18: 0x7fc8c8b4441c - clone Oct 11 13:31:39.672 INFO blam! 19: 0x0 - Oct 11 13:31:39.672 INFO blam! Oct 11 13:31:39.672 INFO blam! ---- logging_string stdout ---- Oct 11 13:31:39.672 INFO blam! Logger::log() open error: Oct 11 13:31:39.672 INFO blam! Read-only file system (os error 30) Oct 11 13:31:39.672 INFO blam! Oct 11 13:31:39.672 INFO blam! thread 'logging_string' panicked at 'assertion failed: log.log(&String::from("logging_string()"))', tests/tests.rs:49:5 Oct 11 13:31:39.672 INFO blam! stack backtrace: Oct 11 13:31:39.672 INFO blam! 0: 0x56405136317e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 13:31:39.672 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 13:31:39.672 INFO blam! 1: 0x56405136c026 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 13:31:39.672 INFO blam! 2: 0x564051366d7d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:211 Oct 11 13:31:39.672 INFO blam! 3: 0x564051366a8b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:221 Oct 11 13:31:39.672 INFO blam! 4: 0x56405136742c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:476 Oct 11 13:31:39.672 INFO blam! 5: 0x5640513532ef - std::panicking::begin_panic::h115170853f476d93 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:410 Oct 11 13:31:39.672 INFO blam! 6: 0x5640512f5c5d - tests::logging_string::he3a38e9d1ae11560 Oct 11 13:31:39.672 INFO blam! at tests/tests.rs:49 Oct 11 13:31:39.672 INFO blam! 7: 0x5640512f5b69 - tests::logging_string::{{closure}}::ha1e8e7b581d27c62 Oct 11 13:31:39.672 INFO blam! at tests/tests.rs:46 Oct 11 13:31:39.672 INFO blam! 8: 0x5640512f747d - core::ops::function::FnOnce::call_once::h152d4ab9b6b2cdf8 Oct 11 13:31:39.672 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.672 INFO blam! 9: 0x5640512fb5ce - >::call_box::h95b7cb918af67b5d Oct 11 13:31:39.672 INFO blam! at libtest/lib.rs:1468 Oct 11 13:31:39.672 INFO blam! at libcore/ops/function.rs:238 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.672 INFO blam! 10: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.672 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.672 INFO blam! 11: 0x56405131c11d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.672 INFO blam! at libtest/lib.rs:1423 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 13:31:39.672 INFO blam! 12: 0x56405131cd24 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 13:31:39.672 INFO blam! at libstd/thread/mod.rs:409 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:313 Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:310 Oct 11 13:31:39.672 INFO blam! 13: 0x5640513771f9 - __rust_maybe_catch_panic Oct 11 13:31:39.672 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 13:31:39.672 INFO blam! 14: 0x56405130a2e6 - >::call_box::h96125cb29a9ba44b Oct 11 13:31:39.672 INFO blam! at libstd/panicking.rs:289 Oct 11 13:31:39.672 INFO blam! at libstd/panic.rs:392 Oct 11 13:31:39.672 INFO blam! at libstd/thread/mod.rs:408 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:672 Oct 11 13:31:39.672 INFO blam! 15: 0x5640513651ba - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 13:31:39.672 INFO blam! at liballoc/boxed.rs:682 Oct 11 13:31:39.672 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 13:31:39.673 INFO blam! 16: 0x56405135a935 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 13:31:39.673 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 13:31:39.673 INFO blam! 17: 0x7fc8c90246b9 - start_thread Oct 11 13:31:39.673 INFO blam! 18: 0x7fc8c8b4441c - clone Oct 11 13:31:39.673 INFO blam! 19: 0x0 - Oct 11 13:31:39.673 INFO blam! Oct 11 13:31:39.673 INFO blam! Oct 11 13:31:39.673 INFO blam! failures: Oct 11 13:31:39.673 INFO blam! custom_format Oct 11 13:31:39.673 INFO blam! empty_format Oct 11 13:31:39.673 INFO blam! logging_reverse_format Oct 11 13:31:39.673 INFO blam! logging_str Oct 11 13:31:39.673 INFO blam! logging_string Oct 11 13:31:39.673 INFO blam! Oct 11 13:31:39.673 INFO blam! test result: FAILED. 4 passed; 5 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 13:31:39.673 INFO blam! Oct 11 13:31:39.673 INFO kablam! error: test failed, to rerun pass '--test tests' Oct 11 13:31:39.673 INFO kablam! su: No module specific data is present Oct 11 13:31:40.087 INFO running `"docker" "rm" "-f" "dbcffb3b39187e7743bfa0538991cd3ea88b587d61db2f170dd760f2251d7168"` Oct 11 13:31:40.238 INFO blam! dbcffb3b39187e7743bfa0538991cd3ea88b587d61db2f170dd760f2251d7168