Oct 11 16:27:31.606 INFO testing msi-0.2.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 16:27:31.606 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 16:27:31.606 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/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:27:31.943 INFO blam! 92c31db7458daa81aa946622dba39a763b1100effccd10df696eceeed2cfb7d2
Oct 11 16:27:31.945 INFO running `"docker" "start" "-a" "92c31db7458daa81aa946622dba39a763b1100effccd10df696eceeed2cfb7d2"`
Oct 11 16:27:32.548 INFO kablam! usermod: no changes
Oct 11 16:27:32.610 INFO kablam!    Compiling cfb v0.3.1
Oct 11 16:27:35.692 INFO kablam!    Compiling msi v0.2.0 (/source)
Oct 11 16:27:39.889 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 7.32s
Oct 11 16:27:39.893 INFO kablam! su: No module specific data is present
Oct 11 16:27:40.224 INFO running `"docker" "rm" "-f" "92c31db7458daa81aa946622dba39a763b1100effccd10df696eceeed2cfb7d2"`
Oct 11 16:27:40.406 INFO blam! 92c31db7458daa81aa946622dba39a763b1100effccd10df696eceeed2cfb7d2
Oct 11 16:27:40.412 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 16:27:40.414 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/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:27:40.689 INFO blam! a571693599555a52edf6528d3b20dd84774e20932f4e3fb62838cbec37d00b00
Oct 11 16:27:40.696 INFO running `"docker" "start" "-a" "a571693599555a52edf6528d3b20dd84774e20932f4e3fb62838cbec37d00b00"`
Oct 11 16:27:41.829 INFO kablam! usermod: no changes
Oct 11 16:27:41.944 INFO kablam!    Compiling msi v0.2.0 (/source)
Oct 11 16:27:46.641 INFO kablam! warning: unnecessary parentheses around method argument
Oct 11 16:27:46.641 INFO kablam!   --> tests/delete.rs:58:15
Oct 11 16:27:46.641 INFO kablam!    |
Oct 11 16:27:46.641 INFO kablam! 58 |         .with((Expr::col("Foo").eq(Expr::integer(2))));
Oct 11 16:27:46.641 INFO kablam!    |               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: remove these parentheses
Oct 11 16:27:46.652 INFO kablam!    |
Oct 11 16:27:46.652 INFO kablam!    = note: #[warn(unused_parens)] on by default
Oct 11 16:27:46.652 INFO kablam! 
Oct 11 16:28:07.565 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 25.69s
Oct 11 16:28:07.569 INFO kablam! su: No module specific data is present
Oct 11 16:28:08.020 INFO running `"docker" "rm" "-f" "a571693599555a52edf6528d3b20dd84774e20932f4e3fb62838cbec37d00b00"`
Oct 11 16:28:08.296 INFO blam! a571693599555a52edf6528d3b20dd84774e20932f4e3fb62838cbec37d00b00
Oct 11 16:28:08.312 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 16:28:08.312 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/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:28:08.902 INFO blam! c783918771ddbf1e05f640b4bd1760d4e28ac6b827f0793f579c8a3a85e94c7c
Oct 11 16:28:08.903 INFO running `"docker" "start" "-a" "c783918771ddbf1e05f640b4bd1760d4e28ac6b827f0793f579c8a3a85e94c7c"`
Oct 11 16:28:10.220 INFO kablam! usermod: no changes
Oct 11 16:28:10.367 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Oct 11 16:28:10.379 INFO kablam!      Running /target/debug/deps/msi-4b243a14bedb76dd
Oct 11 16:28:10.384 INFO blam! 
Oct 11 16:28:10.384 INFO blam! running 55 tests
Oct 11 16:28:10.385 INFO blam! test internal::codepage::tests::decode_string ... ok
Oct 11 16:28:10.385 INFO blam! test internal::column::tests::valid_column_value ... ok
Oct 11 16:28:10.385 INFO blam! test internal::column::tests::valid_column_name ... ok
Oct 11 16:28:10.385 INFO blam! test internal::column::tests::read_column_value ... ok
Oct 11 16:28:10.385 INFO blam! test internal::column::tests::write_column_value ... ok
Oct 11 16:28:10.392 INFO blam! test internal::expr::tests::column_names ... ok
Oct 11 16:28:10.392 INFO blam! test internal::expr::tests::display ... ok
Oct 11 16:28:10.392 INFO blam! test internal::language::tests::lang_codes_are_sorted ... ok
Oct 11 16:28:10.392 INFO blam! test internal::language::tests::lang_codes_are_unique ... ok
Oct 11 16:28:10.392 INFO blam! test internal::codepage::tests::id_round_trip ... ok
Oct 11 16:28:10.392 INFO blam! test internal::expr::tests::evaluate ... ok
Oct 11 16:28:10.392 INFO blam! test internal::category::tests::category_string_round_trip ... ok
Oct 11 16:28:10.392 INFO blam! test internal::language::tests::sublang_codes_are_sorted ... ok
Oct 11 16:28:10.392 INFO blam! test internal::codepage::tests::encoding_error ... ok
Oct 11 16:28:10.392 INFO blam! test internal::language::tests::lang_tags_are_unique ... ok
Oct 11 16:28:10.392 INFO blam! test internal::codepage::tests::decoding_error ... ok
Oct 11 16:28:10.392 INFO blam! test internal::codepage::tests::encode_string ... ok
Oct 11 16:28:10.416 INFO blam! test internal::language::tests::sublang_tags_start_with_lang_tag ... ok
Oct 11 16:28:10.424 INFO blam! test internal::language::tests::sublang_tags_are_unique ... ok
Oct 11 16:28:10.424 INFO blam! test internal::language::tests::sublang_codes_are_unique ... ok
Oct 11 16:28:10.436 INFO blam! test internal::package::tests::select_rows ... ok
Oct 11 16:28:10.436 INFO blam! test internal::package::tests::set_database_codepage ... ok
Oct 11 16:28:10.436 INFO blam! test internal::propset::tests::read_property_set ... ok
Oct 11 16:28:10.436 INFO blam! test internal::propset::tests::read_property_value ... ok
Oct 11 16:28:10.436 INFO blam! test internal::package::tests::insert_rows ... ok
Oct 11 16:28:10.436 INFO blam! test internal::query::tests::display_insert ... ok
Oct 11 16:28:10.436 INFO blam! test internal::query::tests::display_select ... ok
Oct 11 16:28:10.437 INFO blam! test internal::propset::tests::write_property_set ... ok
Oct 11 16:28:10.437 INFO blam! test internal::streamname::tests::encode_stream_name ... ok
Oct 11 16:28:10.437 INFO blam! test internal::streamname::tests::is_valid_stream_name ... ok
Oct 11 16:28:10.440 INFO blam! test internal::streamname::tests::to_from_b64 ... ok
Oct 11 16:28:10.452 INFO blam! test internal::package::tests::join_tables ... ok
Oct 11 16:28:10.452 INFO blam! test internal::package::tests::update_rows ... ok
Oct 11 16:28:10.452 INFO blam! test internal::stringpool::tests::long_string_refs ... ok
Oct 11 16:28:10.456 INFO blam! test internal::stringpool::tests::max_refcount ... ok
Oct 11 16:28:10.456 INFO blam! test internal::stringpool::tests::build_string_pool ... ok
Oct 11 16:28:10.456 INFO blam! test internal::query::tests::display_delete ... ok
Oct 11 16:28:10.456 INFO blam! test internal::streamname::tests::decode_stream_name ... ok
Oct 11 16:28:10.456 INFO blam! test internal::query::tests::display_update ... ok
Oct 11 16:28:10.456 INFO blam! test internal::propset::tests::write_property_value ... ok
Oct 11 16:28:10.456 INFO blam! test internal::stringpool::tests::read_string_ref ... ok
Oct 11 16:28:10.456 INFO blam! test internal::stringpool::tests::new_string_pool ... ok
Oct 11 16:28:10.458 INFO blam! test internal::summary::tests::set_properties ... ok
Oct 11 16:28:10.458 INFO blam! test internal::stringpool::tests::repeated_string ... ok
Oct 11 16:28:10.458 INFO blam! test internal::stringpool::tests::reuse_entries ... ok
Oct 11 16:28:10.459 INFO blam! test internal::stringpool::tests::write_string_ref ... ok
Oct 11 16:28:10.459 INFO blam! test internal::stringpool::tests::write_string_pool ... ok
Oct 11 16:28:10.459 INFO blam! test internal::table::tests::valid_table_name ... ok
Oct 11 16:28:10.459 INFO blam! test internal::value::tests::create_value_ref ... ok
Oct 11 16:28:10.459 INFO blam! test internal::time::tests::to_system_time ... ok
Oct 11 16:28:10.459 INFO blam! test internal::value::tests::format_value ... ok
Oct 11 16:28:10.459 INFO blam! test internal::value::tests::value_from ... ok
Oct 11 16:28:10.459 INFO blam! test internal::time::tests::from_system_time ... ok
Oct 11 16:28:10.516 INFO blam! test internal::stringpool::tests::invalid_codepage ... ok
Oct 11 16:28:10.520 INFO blam! test internal::propset::tests::property_value_round_trip ... FAILED
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO blam! failures:
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO blam! ---- internal::propset::tests::property_value_round_trip stdout ----
Oct 11 16:28:10.521 INFO blam! thread 'internal::propset::tests::property_value_round_trip' panicked at 'assertion failed: `(left == right)`
Oct 11 16:28:10.521 INFO blam!   left: `FileTime(SystemTime { tv_sec: 1539275290, tv_nsec: 416703100 })`,
Oct 11 16:28:10.521 INFO blam!  right: `FileTime(SystemTime { tv_sec: 1539275290, tv_nsec: 416703110 })`', src/internal/propset.rs:466:13
Oct 11 16:28:10.521 INFO blam! stack backtrace:
Oct 11 16:28:10.521 INFO blam!    0:     0x56209993c8ee - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 11 16:28:10.521 INFO blam!    1:     0x5620999458f6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Oct 11 16:28:10.521 INFO blam!    2:     0x56209994064d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:211
Oct 11 16:28:10.521 INFO blam!    3:     0x56209994035b - std::panicking::default_hook::h1ef46fa7cd894809
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:221
Oct 11 16:28:10.521 INFO blam!    4:     0x562099940cfc - std::panicking::rust_panic_with_hook::h05510fde8841c579
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:476
Oct 11 16:28:10.521 INFO blam!    5:     0x5620999408b9 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:390
Oct 11 16:28:10.521 INFO blam!    6:     0x56209994081d - std::panicking::begin_panic_fmt::h0063f49bf5a35411
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:345
Oct 11 16:28:10.521 INFO blam!    7:     0x56209979958b - msi::internal::propset::tests::property_value_round_trip::h4ab7237b9ef382fb
Oct 11 16:28:10.521 INFO blam!                                at src/internal/propset.rs:466
Oct 11 16:28:10.521 INFO blam!    8:     0x562099798df9 - msi::internal::propset::tests::property_value_round_trip::{{closure}}::h7d63bfc911855e9f
Oct 11 16:28:10.521 INFO blam!                                at src/internal/propset.rs:445
Oct 11 16:28:10.521 INFO blam!    9:     0x5620997c171d - core::ops::function::FnOnce::call_once::h4d67e2b2063799ee
Oct 11 16:28:10.521 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:28:10.521 INFO blam!   10:     0x5620998b79ae - <F as alloc::boxed::FnBox<A>>::call_box::h95b7cb918af67b5d
Oct 11 16:28:10.521 INFO blam!                                at libtest/lib.rs:1468
Oct 11 16:28:10.521 INFO blam!                                at libcore/ops/function.rs:238
Oct 11 16:28:10.521 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:28:10.521 INFO blam!   11:     0x562099950ac9 - __rust_maybe_catch_panic
Oct 11 16:28:10.521 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:28:10.521 INFO blam!   12:     0x5620998d84fd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:28:10.521 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:28:10.521 INFO blam!                                at libtest/lib.rs:1423
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Oct 11 16:28:10.521 INFO blam!   13:     0x5620998d9104 - std::panicking::try::do_call::ha990a345054c2d63
Oct 11 16:28:10.521 INFO blam!                                at libstd/thread/mod.rs:409
Oct 11 16:28:10.521 INFO blam!                                at libstd/panic.rs:313
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:310
Oct 11 16:28:10.521 INFO blam!   14:     0x562099950ac9 - __rust_maybe_catch_panic
Oct 11 16:28:10.521 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 11 16:28:10.521 INFO blam!   15:     0x5620998c66c6 - <F as alloc::boxed::FnBox<A>>::call_box::h96125cb29a9ba44b
Oct 11 16:28:10.521 INFO blam!                                at libstd/panicking.rs:289
Oct 11 16:28:10.521 INFO blam!                                at libstd/panic.rs:392
Oct 11 16:28:10.521 INFO blam!                                at libstd/thread/mod.rs:408
Oct 11 16:28:10.521 INFO blam!                                at liballoc/boxed.rs:672
Oct 11 16:28:10.521 INFO blam!   16:     0x56209993ea8a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1
Oct 11 16:28:10.521 INFO blam!                                at liballoc/boxed.rs:682
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys_common/thread.rs:24
Oct 11 16:28:10.521 INFO blam!   17:     0x562099933f15 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886
Oct 11 16:28:10.521 INFO blam!                                at libstd/sys/unix/thread.rs:90
Oct 11 16:28:10.521 INFO blam!   18:     0x7fee44de06b9 - start_thread
Oct 11 16:28:10.521 INFO blam!   19:     0x7fee4490041c - clone
Oct 11 16:28:10.521 INFO blam!   20:                0x0 - <unknown>
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO blam! failures:
Oct 11 16:28:10.521 INFO blam!     internal::propset::tests::property_value_round_trip
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO blam! test result: FAILED. 54 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 16:28:10.521 INFO blam! 
Oct 11 16:28:10.521 INFO kablam! error: test failed, to rerun pass '--lib'
Oct 11 16:28:10.521 INFO kablam! su: No module specific data is present
Oct 11 16:28:11.250 INFO running `"docker" "rm" "-f" "c783918771ddbf1e05f640b4bd1760d4e28ac6b827f0793f579c8a3a85e94c7c"`
Oct 11 16:28:11.573 INFO blam! c783918771ddbf1e05f640b4bd1760d4e28ac6b827f0793f579c8a3a85e94c7c