Oct 16 10:45:25.596 INFO testing fw-1.11.0 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 16 10:45:25.598 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/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 16 10:45:25.976 INFO blam! 772b27d8c71dba7d7a4907aa710b21d04e2fc28a7d2d4cb35a2921e4567a98b3
Oct 16 10:45:25.981 INFO running `"docker" "start" "-a" "772b27d8c71dba7d7a4907aa710b21d04e2fc28a7d2d4cb35a2921e4567a98b3"`
Oct 16 10:45:26.532 INFO kablam! usermod: no changes
Oct 16 10:45:26.883 INFO kablam!    Compiling crossbeam-epoch v0.6.0
Oct 16 10:45:26.883 INFO kablam!    Compiling crossbeam-deque v0.5.2
Oct 16 10:45:26.883 INFO kablam!    Compiling slog-async v2.3.0
Oct 16 10:45:26.887 INFO kablam!    Compiling slog-term v2.4.0
Oct 16 10:45:26.887 INFO kablam!    Compiling libgit2-sys v0.7.10
Oct 16 10:45:26.887 INFO kablam!    Compiling rayon v1.0.2
Oct 16 10:45:26.887 INFO kablam!    Compiling console v0.6.2
Oct 16 10:45:26.887 INFO kablam!    Compiling spectral v0.6.0
Oct 16 10:45:31.913 INFO kablam!    Compiling ring v0.12.1
Oct 16 10:45:31.927 INFO kablam!    Compiling git2 v0.7.5
Oct 16 10:45:31.928 INFO kablam!    Compiling crossbeam-channel v0.2.6
Oct 16 10:45:35.923 INFO kablam!    Compiling indicatif v0.9.0
Oct 16 10:45:40.930 INFO kablam!    Compiling crossbeam v0.4.1
Oct 16 10:45:54.119 INFO kablam!    Compiling sct v0.2.0
Oct 16 10:45:54.119 INFO kablam!    Compiling webpki v0.17.0
Oct 16 10:45:55.149 INFO kablam!    Compiling ct-logs v0.2.0
Oct 16 10:45:55.549 INFO kablam!    Compiling rustls v0.11.0
Oct 16 10:45:55.550 INFO kablam!    Compiling webpki-roots v0.13.0
Oct 16 10:46:05.909 INFO kablam!    Compiling tokio-rustls v0.4.0
Oct 16 10:46:11.107 INFO kablam!    Compiling hyper-rustls v0.11.0
Oct 16 10:46:16.403 INFO kablam!    Compiling github-gql-rs v0.0.1
Oct 16 10:46:21.862 INFO kablam!    Compiling fw v1.11.0 (/source)
Oct 16 10:46:41.421 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1m 14s
Oct 16 10:46:41.436 INFO kablam! su: No module specific data is present
Oct 16 10:46:41.837 INFO running `"docker" "rm" "-f" "772b27d8c71dba7d7a4907aa710b21d04e2fc28a7d2d4cb35a2921e4567a98b3"`
Oct 16 10:46:41.931 INFO blam! 772b27d8c71dba7d7a4907aa710b21d04e2fc28a7d2d4cb35a2921e4567a98b3
Oct 16 10:46:41.933 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/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 16 10:46:42.120 INFO blam! b8335ec26e38baaa3ad5bd4f338e98a2668340fc5413e623ae9bdca9353b5cf9
Oct 16 10:46:42.122 INFO running `"docker" "start" "-a" "b8335ec26e38baaa3ad5bd4f338e98a2668340fc5413e623ae9bdca9353b5cf9"`
Oct 16 10:46:42.514 INFO kablam! usermod: no changes
Oct 16 10:46:42.774 INFO kablam!    Compiling fw v1.11.0 (/source)
Oct 16 10:46:56.262 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 13.73s
Oct 16 10:46:56.276 INFO kablam! su: No module specific data is present
Oct 16 10:46:56.589 INFO running `"docker" "rm" "-f" "b8335ec26e38baaa3ad5bd4f338e98a2668340fc5413e623ae9bdca9353b5cf9"`
Oct 16 10:46:56.667 INFO blam! b8335ec26e38baaa3ad5bd4f338e98a2668340fc5413e623ae9bdca9353b5cf9
Oct 16 10:46:56.669 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-5/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling-1/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 16 10:46:56.854 INFO blam! 08996602a85c81f3b87d02e8c107e44c1b050e795396b0f3d1114e6e2a4434b6
Oct 16 10:46:56.857 INFO running `"docker" "start" "-a" "08996602a85c81f3b87d02e8c107e44c1b050e795396b0f3d1114e6e2a4434b6"`
Oct 16 10:46:57.215 INFO kablam! usermod: no changes
Oct 16 10:46:57.475 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Oct 16 10:46:57.497 INFO kablam!      Running /target/debug/deps/fw-e676e6f45e14a602
Oct 16 10:46:57.579 INFO blam! 
Oct 16 10:46:57.579 INFO blam! running 19 tests
Oct 16 10:46:57.579 INFO blam! Oct 16 10:46:57.579 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 16 10:46:57.579 INFO blam! Oct 16 10:46:57.579 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.580 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.580 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.580 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.580 INFO blam! Oct 16 10:46:57.579 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.580 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.580 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.580 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone2"), after_workon: Some("workon2"), priority: None, workspace: None }, tag_name: tag2
Oct 16 10:46:57.580 INFO blam! Oct 16 10:46:57.579 TRCE before sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 16 10:46:57.580 INFO blam! Oct 16 10:46:57.579 TRCE after sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 16 10:46:57.580 INFO blam! test config::tests::test_after_clone_from_tags ... ok
Oct 16 10:46:57.580 INFO blam! test config::tests::test_do_expand_path ... ok
Oct 16 10:46:57.580 INFO blam! test config::tests::test_repo_name_from_ssh_pragma_with_multiple_git_endings ... ok
Oct 16 10:46:57.580 INFO blam! test config::tests::test_repo_name_from_ssh_pragma ... ok
Oct 16 10:46:57.580 INFO blam! Oct 16 10:46:57.580 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 16 10:46:57.594 INFO blam! test config::tests::test_do_not_expand_path_without_tilde ... ok
Oct 16 10:46:57.594 INFO blam! test config::tests::test_repo_name_from_url ... ok
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 TRCE Resolving, tags: Some({"tag1"})
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.594 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.594 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.594 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 TRCE before sort, tags: [("clone1", 50)]
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 TRCE after sort, tags: [("clone1", 50)]
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.580 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 16 10:46:57.594 INFO blam! test config::tests::test_after_clone_override_from_project ... ok
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 TRCE before sort, tags: []
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.581 TRCE after sort, tags: []
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE Resolving, tags: Some({"tag1"})
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE before sort, tags: [("workon3", 100), ("workon4", 0)]
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.594 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.594 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.594 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE before sort, tags: [("workon1", 50)]
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE after sort, tags: [("workon1", 50)]
Oct 16 10:46:57.594 INFO blam! Oct 16 10:46:57.583 TRCE after sort, tags: [("workon4", 0), ("workon3", 100)]
Oct 16 10:46:57.594 INFO blam! test config::tests::test_after_clone_from_tags_missing_all_tags_graceful ... ok
Oct 16 10:46:57.594 INFO blam! test config::tests::test_workon_override_from_project ... ok
Oct 16 10:46:57.594 INFO blam! test config::tests::test_workon_from_tags_prioritized ... ok
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist", "tag1"})
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.595 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.595 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.595 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE before sort, tags: [("workon1", 50)]
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE after sort, tags: [("workon1", 50)]
Oct 16 10:46:57.595 INFO blam! test export::tests::test_workon_override_from_project ... ok
Oct 16 10:46:57.595 INFO blam! test config::tests::test_workon_from_tags_missing_one_tag_graceful ... ok
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE before sort, tags: []
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.591 TRCE after sort, tags: []
Oct 16 10:46:57.595 INFO blam! test config::tests::test_workon_from_tags_missing_all_tags_graceful ... ok
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.592 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.592 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.595 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.595 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.595 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.595 INFO blam! Oct 16 10:46:57.592 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.596 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.596 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.596 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone2"), after_workon: Some("workon2"), priority: None, workspace: None }, tag_name: tag2
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.592 TRCE before sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.592 TRCE after sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 16 10:46:57.596 INFO blam! test config::tests::test_workon_from_tags ... ok
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.592 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.592 TRCE before sort, tags: [("clone3", 100), ("clone4", 0)]
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.592 TRCE after sort, tags: [("clone4", 0), ("clone3", 100)]
Oct 16 10:46:57.596 INFO blam! test config::tests::test_after_clone_from_tags_prioritized ... ok
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.593 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.593 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist", "tag1"})
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.593 DEBG No tag priority set, will use default (50).
Oct 16 10:46:57.596 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 16 10:46:57.596 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 16 10:46:57.596 INFO blam! conscious choice and set the value., tag_def: Tag { after_clone: Some("clone1"), after_workon: Some("workon1"), priority: None, workspace: None }, tag_name: tag1
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.593 TRCE before sort, tags: [("clone1", 50)]
Oct 16 10:46:57.596 INFO blam! Oct 16 10:46:57.593 TRCE after sort, tags: [("clone1", 50)]
Oct 16 10:46:57.596 INFO blam! test config::tests::test_after_clone_from_tags_missing_one_tag_graceful ... ok
Oct 16 10:46:57.596 INFO blam! test projectile::tests::test_replace_path_with_tilde ... ok
Oct 16 10:46:57.597 INFO blam! Oct 16 10:46:57.595 DEBG Writing projectile entry, entry: /home/mriehl/test
Oct 16 10:46:57.597 INFO blam! Oct 16 10:46:57.596 DEBG Writing projectile entry, entry: /home/mriehl/go/src/github.com/test2
Oct 16 10:46:57.597 INFO blam! test projectile::tests::test_persists_projectile_config ... ok
Oct 16 10:46:57.695 INFO blam! test sync::tests::test_username_from_git_url ... ok
Oct 16 10:46:57.695 INFO blam! 
Oct 16 10:46:57.695 INFO blam! test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 10:46:57.695 INFO blam! 
Oct 16 10:46:57.711 INFO kablam! su: No module specific data is present
Oct 16 10:46:58.491 INFO running `"docker" "rm" "-f" "08996602a85c81f3b87d02e8c107e44c1b050e795396b0f3d1114e6e2a4434b6"`
Oct 16 10:46:58.743 INFO blam! 08996602a85c81f3b87d02e8c107e44c1b050e795396b0f3d1114e6e2a4434b6