Dec 15 16:41:21.386 INFO testing dogear-0.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 16:41:21.386 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 16:41:21.826 INFO [stdout] 775cd25ae34cc72a32afcd1c29034ad02158768476ff85334419e3aff1995d9f
Dec 15 16:41:21.831 INFO running `"docker" "start" "-a" "775cd25ae34cc72a32afcd1c29034ad02158768476ff85334419e3aff1995d9f"`
Dec 15 16:41:22.618 INFO [stderr] usermod: no changes
Dec 15 16:41:22.731 INFO [stderr]    Compiling dogear v0.1.1 (/source)
Dec 15 16:41:25.842 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.20s
Dec 15 16:41:25.852 INFO [stderr] su: No module specific data is present
Dec 15 16:41:26.796 INFO running `"docker" "inspect" "775cd25ae34cc72a32afcd1c29034ad02158768476ff85334419e3aff1995d9f"`
Dec 15 16:41:27.021 INFO running `"docker" "rm" "-f" "775cd25ae34cc72a32afcd1c29034ad02158768476ff85334419e3aff1995d9f"`
Dec 15 16:41:27.280 INFO [stdout] 775cd25ae34cc72a32afcd1c29034ad02158768476ff85334419e3aff1995d9f
Dec 15 16:41:27.291 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 16:41:27.724 INFO [stdout] c9f1f726239a62762bebeaf8d4ec8ace1e4b63423a1d7aecb5116087d446a92c
Dec 15 16:41:27.731 INFO running `"docker" "start" "-a" "c9f1f726239a62762bebeaf8d4ec8ace1e4b63423a1d7aecb5116087d446a92c"`
Dec 15 16:41:28.894 INFO [stderr] usermod: no changes
Dec 15 16:41:29.067 INFO [stderr]    Compiling dogear v0.1.1 (/source)
Dec 15 16:41:32.103 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.103 INFO [stderr]     --> src/merge.rs:1349:13
Dec 15 16:41:32.103 INFO [stderr]      |
Dec 15 16:41:32.103 INFO [stderr] 1349 |         let shared_tree = nodes!({
Dec 15 16:41:32.103 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.103 INFO [stderr]      |
Dec 15 16:41:32.103 INFO [stderr]      = note: #[warn(unused_variables)] on by default
Dec 15 16:41:32.103 INFO [stderr] 
Dec 15 16:41:32.103 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.103 INFO [stderr]     --> src/merge.rs:1438:13
Dec 15 16:41:32.103 INFO [stderr]      |
Dec 15 16:41:32.103 INFO [stderr] 1438 |         let shared_tree = nodes!({
Dec 15 16:41:32.103 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.103 INFO [stderr] 
Dec 15 16:41:32.103 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.103 INFO [stderr]     --> src/merge.rs:1511:13
Dec 15 16:41:32.103 INFO [stderr]      |
Dec 15 16:41:32.103 INFO [stderr] 1511 |         let shared_tree = nodes!({
Dec 15 16:41:32.103 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.103 INFO [stderr] 
Dec 15 16:41:32.103 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.103 INFO [stderr]     --> src/merge.rs:1584:13
Dec 15 16:41:32.103 INFO [stderr]      |
Dec 15 16:41:32.104 INFO [stderr] 1584 |         let shared_tree = nodes!({
Dec 15 16:41:32.104 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.104 INFO [stderr] 
Dec 15 16:41:32.104 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.104 INFO [stderr]     --> src/merge.rs:1682:13
Dec 15 16:41:32.104 INFO [stderr]      |
Dec 15 16:41:32.104 INFO [stderr] 1682 |         let shared_tree = nodes!({
Dec 15 16:41:32.104 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.104 INFO [stderr] 
Dec 15 16:41:32.104 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.104 INFO [stderr]     --> src/merge.rs:1775:13
Dec 15 16:41:32.104 INFO [stderr]      |
Dec 15 16:41:32.104 INFO [stderr] 1775 |         let shared_tree = nodes!({
Dec 15 16:41:32.104 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.104 INFO [stderr] 
Dec 15 16:41:32.105 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.105 INFO [stderr]     --> src/merge.rs:1890:13
Dec 15 16:41:32.105 INFO [stderr]      |
Dec 15 16:41:32.105 INFO [stderr] 1890 |         let shared_tree = nodes!({
Dec 15 16:41:32.105 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.105 INFO [stderr] 
Dec 15 16:41:32.105 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.105 INFO [stderr]     --> src/merge.rs:1975:13
Dec 15 16:41:32.105 INFO [stderr]      |
Dec 15 16:41:32.105 INFO [stderr] 1975 |         let shared_tree = nodes!({
Dec 15 16:41:32.105 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.105 INFO [stderr] 
Dec 15 16:41:37.704 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.78s
Dec 15 16:41:37.709 INFO [stderr] su: No module specific data is present
Dec 15 16:41:38.533 INFO running `"docker" "inspect" "c9f1f726239a62762bebeaf8d4ec8ace1e4b63423a1d7aecb5116087d446a92c"`
Dec 15 16:41:38.705 INFO running `"docker" "rm" "-f" "c9f1f726239a62762bebeaf8d4ec8ace1e4b63423a1d7aecb5116087d446a92c"`
Dec 15 16:41:38.965 INFO [stdout] c9f1f726239a62762bebeaf8d4ec8ace1e4b63423a1d7aecb5116087d446a92c
Dec 15 16:41:38.972 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 16:41:39.319 INFO [stdout] f653d084c56694b756653594823dc2e62bd92f1fb60c5b9cc8c26c16017adba6
Dec 15 16:41:39.319 INFO running `"docker" "start" "-a" "f653d084c56694b756653594823dc2e62bd92f1fb60c5b9cc8c26c16017adba6"`
Dec 15 16:41:40.602 INFO [stderr] usermod: no changes
Dec 15 16:41:40.695 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 15 16:41:40.711 INFO [stderr]      Running /target/debug/deps/dogear-7d9a9575b356702d
Dec 15 16:41:40.712 INFO [stdout] 
Dec 15 16:41:40.712 INFO [stdout] running 22 tests
Dec 15 16:41:40.735 INFO [stdout] test merge::tests::applying_two_empty_folders_doesnt_smush ... ok
Dec 15 16:41:40.735 INFO [stdout] test merge::tests::complex_deduping ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::clear_folder_then_delete ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::applying_two_empty_folders_matches_only_one ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::deduping_ignores_parent_title ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::complex_orphaning ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::complex_move_with_additions ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::deduping_remote_newer ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::invalid_guids ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::deduping_local_newer ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::locally_modified_remotely_deleted ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::mismatched_incompatible_bookmark_kinds ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::move_into_parent_sibling ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::left_pane_root ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::newer_move_to_deleted ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::locally_deleted_remotely_modified ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::mismatched_compatible_bookmark_kinds ... ok
Dec 15 16:41:40.747 INFO [stdout] test merge::tests::value_structure_conflict ... ok
Dec 15 16:41:40.747 INFO [stderr] ERROR 2018-12-15T16:41:40Z: dogear::merge: Merging local bookmarkAAAA (Bookmark; Age = 0ms; Unmerged) and remote bookmarkAAAA (Folder; Age = 5ms; Unmerged) with different kinds
Dec 15 16:41:40.755 INFO [stderr]    Doc-tests dogear
Dec 15 16:41:40.755 INFO [stdout] test merge::tests::non_syncable_items ... ok
Dec 15 16:41:40.755 INFO [stdout] test merge::tests::nonexistent_on_one_side ... ok
Dec 15 16:41:40.755 INFO [stdout] test merge::tests::reparent_and_reposition ... ok
Dec 15 16:41:40.755 INFO [stdout] test merge::tests::reorder_and_insert ... ok
Dec 15 16:41:40.755 INFO [stdout] 
Dec 15 16:41:40.755 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:41:40.755 INFO [stdout] 
Dec 15 16:41:41.937 INFO [stdout] 
Dec 15 16:41:41.937 INFO [stdout] running 0 tests
Dec 15 16:41:41.937 INFO [stdout] 
Dec 15 16:41:41.937 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:41:41.937 INFO [stdout] 
Dec 15 16:41:41.945 INFO [stderr] su: No module specific data is present
Dec 15 16:41:42.821 INFO running `"docker" "inspect" "f653d084c56694b756653594823dc2e62bd92f1fb60c5b9cc8c26c16017adba6"`
Dec 15 16:41:43.162 INFO running `"docker" "rm" "-f" "f653d084c56694b756653594823dc2e62bd92f1fb60c5b9cc8c26c16017adba6"`
Dec 15 16:41:43.503 INFO [stdout] f653d084c56694b756653594823dc2e62bd92f1fb60c5b9cc8c26c16017adba6