Dec 15 16:41:21.543 INFO testing dogear-0.1.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 16:41:21.543 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.924 INFO [stdout] daf5f7570b110141b7d14a123fd3fcf73ca7ad2176d3c045e0bca953d703c52d
Dec 15 16:41:21.930 INFO running `"docker" "start" "-a" "daf5f7570b110141b7d14a123fd3fcf73ca7ad2176d3c045e0bca953d703c52d"`
Dec 15 16:41:23.075 INFO [stderr] usermod: no changes
Dec 15 16:41:23.243 INFO [stderr]    Compiling dogear v0.1.1 (/source)
Dec 15 16:41:26.791 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.68s
Dec 15 16:41:26.796 INFO [stderr] su: No module specific data is present
Dec 15 16:41:27.217 INFO running `"docker" "inspect" "daf5f7570b110141b7d14a123fd3fcf73ca7ad2176d3c045e0bca953d703c52d"`
Dec 15 16:41:27.473 INFO running `"docker" "rm" "-f" "daf5f7570b110141b7d14a123fd3fcf73ca7ad2176d3c045e0bca953d703c52d"`
Dec 15 16:41:27.698 INFO [stdout] daf5f7570b110141b7d14a123fd3fcf73ca7ad2176d3c045e0bca953d703c52d
Dec 15 16:41:27.707 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:28.209 INFO [stdout] 62df4cc6950dec5e6e504267f052e5bd9d5a8d657627cfce2929f2084de9cd12
Dec 15 16:41:28.216 INFO running `"docker" "start" "-a" "62df4cc6950dec5e6e504267f052e5bd9d5a8d657627cfce2929f2084de9cd12"`
Dec 15 16:41:29.268 INFO [stderr] usermod: no changes
Dec 15 16:41:29.409 INFO [stderr]    Compiling dogear v0.1.1 (/source)
Dec 15 16:41:32.223 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.223 INFO [stderr]     --> src/merge.rs:1349:13
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr] 1349 |         let shared_tree = nodes!({
Dec 15 16:41:32.223 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr]      = note: #[warn(unused_variables)] on by default
Dec 15 16:41:32.223 INFO [stderr] 
Dec 15 16:41:32.223 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.223 INFO [stderr]     --> src/merge.rs:1438:13
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr] 1438 |         let shared_tree = nodes!({
Dec 15 16:41:32.223 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.223 INFO [stderr] 
Dec 15 16:41:32.223 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.223 INFO [stderr]     --> src/merge.rs:1511:13
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr] 1511 |         let shared_tree = nodes!({
Dec 15 16:41:32.223 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.223 INFO [stderr] 
Dec 15 16:41:32.223 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.223 INFO [stderr]     --> src/merge.rs:1584:13
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr] 1584 |         let shared_tree = nodes!({
Dec 15 16:41:32.223 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.223 INFO [stderr] 
Dec 15 16:41:32.223 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.223 INFO [stderr]     --> src/merge.rs:1682:13
Dec 15 16:41:32.223 INFO [stderr]      |
Dec 15 16:41:32.223 INFO [stderr] 1682 |         let shared_tree = nodes!({
Dec 15 16:41:32.224 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.224 INFO [stderr] 
Dec 15 16:41:32.224 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.224 INFO [stderr]     --> src/merge.rs:1775:13
Dec 15 16:41:32.224 INFO [stderr]      |
Dec 15 16:41:32.224 INFO [stderr] 1775 |         let shared_tree = nodes!({
Dec 15 16:41:32.224 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.224 INFO [stderr] 
Dec 15 16:41:32.224 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.224 INFO [stderr]     --> src/merge.rs:1890:13
Dec 15 16:41:32.224 INFO [stderr]      |
Dec 15 16:41:32.224 INFO [stderr] 1890 |         let shared_tree = nodes!({
Dec 15 16:41:32.224 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.224 INFO [stderr] 
Dec 15 16:41:32.224 INFO [stderr] warning: unused variable: `shared_tree`
Dec 15 16:41:32.224 INFO [stderr]     --> src/merge.rs:1975:13
Dec 15 16:41:32.224 INFO [stderr]      |
Dec 15 16:41:32.224 INFO [stderr] 1975 |         let shared_tree = nodes!({
Dec 15 16:41:32.224 INFO [stderr]      |             ^^^^^^^^^^^ help: consider using `_shared_tree` instead
Dec 15 16:41:32.224 INFO [stderr] 
Dec 15 16:41:37.439 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.13s
Dec 15 16:41:37.451 INFO [stderr] su: No module specific data is present
Dec 15 16:41:38.095 INFO running `"docker" "inspect" "62df4cc6950dec5e6e504267f052e5bd9d5a8d657627cfce2929f2084de9cd12"`
Dec 15 16:41:38.356 INFO running `"docker" "rm" "-f" "62df4cc6950dec5e6e504267f052e5bd9d5a8d657627cfce2929f2084de9cd12"`
Dec 15 16:41:38.683 INFO [stdout] 62df4cc6950dec5e6e504267f052e5bd9d5a8d657627cfce2929f2084de9cd12
Dec 15 16:41:38.688 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.231 INFO [stdout] 0ae0bd3cc3b12336040338577bfe7b821978d518539716ca4a081c9aee8fbcab
Dec 15 16:41:39.233 INFO running `"docker" "start" "-a" "0ae0bd3cc3b12336040338577bfe7b821978d518539716ca4a081c9aee8fbcab"`
Dec 15 16:41:40.479 INFO [stderr] usermod: no changes
Dec 15 16:41:40.559 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 16:41:40.570 INFO [stderr]      Running /target/debug/deps/dogear-1d090386aed1cafd
Dec 15 16:41:40.575 INFO [stdout] 
Dec 15 16:41:40.575 INFO [stdout] running 22 tests
Dec 15 16:41:40.575 INFO [stdout] test merge::tests::applying_two_empty_folders_doesnt_smush ... ok
Dec 15 16:41:40.575 INFO [stdout] test merge::tests::applying_two_empty_folders_matches_only_one ... ok
Dec 15 16:41:40.575 INFO [stdout] test merge::tests::deduping_local_newer ... ok
Dec 15 16:41:40.575 INFO [stdout] test merge::tests::invalid_guids ... ok
Dec 15 16:41:40.575 INFO [stdout] test merge::tests::deduping_ignores_parent_title ... ok
Dec 15 16:41:40.579 INFO [stdout] test merge::tests::deduping_remote_newer ... ok
Dec 15 16:41:40.579 INFO [stdout] test merge::tests::complex_move_with_additions ... ok
Dec 15 16:41:40.579 INFO [stdout] test merge::tests::complex_orphaning ... ok
Dec 15 16:41:40.579 INFO [stdout] test merge::tests::locally_modified_remotely_deleted ... ok
Dec 15 16:41:40.579 INFO [stdout] test merge::tests::left_pane_root ... ok
Dec 15 16:41:40.591 INFO [stdout] test merge::tests::non_syncable_items ... ok
Dec 15 16:41:40.591 INFO [stdout] test merge::tests::locally_deleted_remotely_modified ... ok
Dec 15 16:41:40.591 INFO [stdout] test merge::tests::complex_deduping ... ok
Dec 15 16:41:40.591 INFO [stdout] test merge::tests::clear_folder_then_delete ... ok
Dec 15 16:41:40.591 INFO [stdout] test merge::tests::mismatched_compatible_bookmark_kinds ... ok
Dec 15 16:41:40.600 INFO [stdout] test merge::tests::nonexistent_on_one_side ... ok
Dec 15 16:41:40.600 INFO [stdout] test merge::tests::mismatched_incompatible_bookmark_kinds ... ok
Dec 15 16:41:40.600 INFO [stdout] test merge::tests::move_into_parent_sibling ... ok
Dec 15 16:41:40.600 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.601 INFO [stdout] test merge::tests::newer_move_to_deleted ... ok
Dec 15 16:41:40.602 INFO [stdout] test merge::tests::reparent_and_reposition ... ok
Dec 15 16:41:40.602 INFO [stdout] test merge::tests::value_structure_conflict ... ok
Dec 15 16:41:40.607 INFO [stdout] test merge::tests::reorder_and_insert ... ok
Dec 15 16:41:40.607 INFO [stdout] 
Dec 15 16:41:40.607 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:41:40.607 INFO [stdout] 
Dec 15 16:41:40.615 INFO [stderr]    Doc-tests dogear
Dec 15 16:41:41.921 INFO [stdout] 
Dec 15 16:41:41.921 INFO [stdout] running 0 tests
Dec 15 16:41:41.921 INFO [stdout] 
Dec 15 16:41:41.921 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:41:41.921 INFO [stdout] 
Dec 15 16:41:41.930 INFO [stderr] su: No module specific data is present
Dec 15 16:41:42.599 INFO running `"docker" "inspect" "0ae0bd3cc3b12336040338577bfe7b821978d518539716ca4a081c9aee8fbcab"`
Dec 15 16:41:42.992 INFO running `"docker" "rm" "-f" "0ae0bd3cc3b12336040338577bfe7b821978d518539716ca4a081c9aee8fbcab"`
Dec 15 16:41:43.287 INFO [stdout] 0ae0bd3cc3b12336040338577bfe7b821978d518539716ca4a081c9aee8fbcab