Oct 15 01:52:37.853 INFO testing brocode/fw against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 15 01:52:37.853 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/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 15 01:52:38.437 INFO blam! 726cc07cecb227ffa413f6566c3bbfa4ded87ce90bd0f721ff017ade0f0dc021
Oct 15 01:52:38.439 INFO running `"docker" "start" "-a" "726cc07cecb227ffa413f6566c3bbfa4ded87ce90bd0f721ff017ade0f0dc021"`
Oct 15 01:52:40.107 INFO kablam! usermod: no changes
Oct 15 01:52:40.631 INFO kablam!    Compiling cc v1.0.19
Oct 15 01:52:40.637 INFO kablam!    Compiling slog v2.3.2
Oct 15 01:52:40.655 INFO kablam!    Compiling dirs v1.0.3
Oct 15 01:52:40.683 INFO kablam!    Compiling log v0.3.9
Oct 15 01:52:40.683 INFO kablam!    Compiling want v0.0.4
Oct 15 01:52:40.683 INFO kablam!    Compiling lock_api v0.1.3
Oct 15 01:52:40.687 INFO kablam!    Compiling num-complex v0.1.43
Oct 15 01:52:40.691 INFO kablam!    Compiling parking_lot_core v0.2.14
Oct 15 01:52:44.755 INFO kablam!    Compiling serde_json v1.0.26
Oct 15 01:52:44.791 INFO kablam!    Compiling crossbeam-epoch v0.5.2
Oct 15 01:52:44.883 INFO kablam!    Compiling num-bigint v0.1.44
Oct 15 01:52:48.695 INFO kablam!    Compiling chrono v0.4.5
Oct 15 01:52:48.696 INFO kablam!    Compiling syn v0.14.9
Oct 15 01:52:48.728 INFO kablam!    Compiling parking_lot v0.6.3
Oct 15 01:52:50.759 INFO kablam!    Compiling slog-async v2.3.0
Oct 15 01:52:58.783 INFO kablam!    Compiling tokio-threadpool v0.1.5
Oct 15 01:52:58.783 INFO kablam!    Compiling crossbeam-deque v0.5.2
Oct 15 01:52:58.969 INFO kablam!    Compiling crossbeam-channel v0.2.4
Oct 15 01:53:08.999 INFO kablam!    Compiling console v0.6.1
Oct 15 01:53:11.303 INFO kablam!    Compiling rayon v1.0.2
Oct 15 01:53:11.347 INFO kablam!    Compiling num-rational v0.1.42
Oct 15 01:53:11.475 INFO kablam!    Compiling slog-term v2.4.0
Oct 15 01:53:11.633 INFO kablam!    Compiling openssl-sys v0.9.35
Oct 15 01:53:11.839 INFO kablam!    Compiling libz-sys v1.0.20
Oct 15 01:53:26.709 INFO kablam!    Compiling cmake v0.1.33
Oct 15 01:53:26.759 INFO kablam!    Compiling backtrace-sys v0.1.24
Oct 15 01:53:26.760 INFO kablam!    Compiling curl-sys v0.4.8
Oct 15 01:53:26.832 INFO kablam!    Compiling ring v0.12.1
Oct 15 01:53:26.900 INFO kablam!    Compiling crossbeam v0.4.1
Oct 15 01:53:27.063 INFO kablam!    Compiling tokio-fs v0.1.3
Oct 15 01:53:44.809 INFO kablam!    Compiling num v0.1.42
Oct 15 01:53:45.012 INFO kablam!    Compiling indicatif v0.9.0
Oct 15 01:53:45.793 INFO kablam!    Compiling libssh2-sys v0.2.10
Oct 15 01:53:47.956 INFO kablam!    Compiling libgit2-sys v0.7.7
Oct 15 01:53:48.055 INFO kablam!    Compiling tokio v0.1.7
Oct 15 01:53:48.349 INFO kablam!    Compiling serde_derive v1.0.72
Oct 15 01:53:50.855 INFO kablam!    Compiling spectral v0.6.0
Oct 15 01:53:53.827 INFO kablam!    Compiling backtrace v0.3.9
Oct 15 01:54:06.831 INFO kablam!    Compiling error-chain v0.11.0
Oct 15 01:54:07.059 INFO kablam!    Compiling error-chain v0.12.0
Oct 15 01:54:07.524 INFO kablam!    Compiling tokio-core v0.1.17
Oct 15 01:54:18.943 INFO kablam!    Compiling webpki v0.17.0
Oct 15 01:54:18.944 INFO kablam!    Compiling sct v0.2.0
Oct 15 01:54:26.623 INFO kablam!    Compiling tokio-proto v0.1.1
Oct 15 01:54:26.679 INFO kablam!    Compiling ct-logs v0.2.0
Oct 15 01:54:26.845 INFO kablam!    Compiling rustls v0.11.0
Oct 15 01:54:26.845 INFO kablam!    Compiling webpki-roots v0.13.0
Oct 15 01:54:42.405 INFO kablam!    Compiling hyper v0.11.27
Oct 15 01:55:07.247 INFO kablam!    Compiling tokio-rustls v0.4.0
Oct 15 01:55:19.747 INFO kablam!    Compiling git2 v0.7.5
Oct 15 01:55:26.031 INFO kablam!    Compiling hyper-rustls v0.11.0
Oct 15 01:55:30.829 INFO kablam!    Compiling github-gql-rs v0.0.1
Oct 15 01:55:37.301 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 15 01:55:56.263 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 3m 16s
Oct 15 01:55:56.282 INFO kablam! su: No module specific data is present
Oct 15 01:55:57.635 INFO running `"docker" "rm" "-f" "726cc07cecb227ffa413f6566c3bbfa4ded87ce90bd0f721ff017ade0f0dc021"`
Oct 15 01:55:57.919 INFO blam! 726cc07cecb227ffa413f6566c3bbfa4ded87ce90bd0f721ff017ade0f0dc021
Oct 15 01:55:57.929 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/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 15 01:55:58.306 INFO blam! 635a736b7e53c948677d27b6a286c6520f8951d9a9a779e51ecfcb553736d447
Oct 15 01:55:58.308 INFO running `"docker" "start" "-a" "635a736b7e53c948677d27b6a286c6520f8951d9a9a779e51ecfcb553736d447"`
Oct 15 01:55:59.527 INFO kablam! usermod: no changes
Oct 15 01:55:59.847 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 15 01:56:10.616 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 11.07s
Oct 15 01:56:10.632 INFO kablam! su: No module specific data is present
Oct 15 01:56:11.381 INFO running `"docker" "rm" "-f" "635a736b7e53c948677d27b6a286c6520f8951d9a9a779e51ecfcb553736d447"`
Oct 15 01:56:11.592 INFO blam! 635a736b7e53c948677d27b6a286c6520f8951d9a9a779e51ecfcb553736d447
Oct 15 01:56:11.594 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/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 15 01:56:11.955 INFO blam! 5ecd92cbb05dd0b7d7dd713b5fc98058e79c20c61548b0a6ee1d2c07d190203d
Oct 15 01:56:11.962 INFO running `"docker" "start" "-a" "5ecd92cbb05dd0b7d7dd713b5fc98058e79c20c61548b0a6ee1d2c07d190203d"`
Oct 15 01:56:12.886 INFO kablam! usermod: no changes
Oct 15 01:56:13.178 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.27s
Oct 15 01:56:13.206 INFO kablam!      Running /target/debug/deps/fw-1d007ac5994e1dd2
Oct 15 01:56:13.231 INFO blam! 
Oct 15 01:56:13.231 INFO blam! running 19 tests
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.275 TRCE Resolving, tags: Some({"tag1"})
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.275 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.277 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.277 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.277 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 15 01:56:13.277 INFO blam! Oct 15 01:56:13.275 TRCE before sort, tags: [("clone1", 50)]
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.275 TRCE after sort, tags: [("clone1", 50)]
Oct 15 01:56:13.277 INFO blam! test config::tests::test_after_clone_override_from_project ... ok
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.276 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.276 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.277 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.277 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.277 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 15 01:56:13.277 INFO blam! Oct 15 01:56:13.276 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.277 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.277 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.277 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 15 01:56:13.277 INFO blam! Oct 15 01:56:13.276 TRCE before sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 15 01:56:13.277 INFO blam! Oct 15 01:56:13.276 TRCE after sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 15 01:56:13.277 INFO blam! test config::tests::test_after_clone_from_tags ... ok
Oct 15 01:56:13.287 INFO blam! test config::tests::test_repo_name_from_ssh_pragma_with_multiple_git_endings ... ok
Oct 15 01:56:13.292 INFO blam! Oct 15 01:56:13.291 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 15 01:56:13.292 INFO blam! Oct 15 01:56:13.291 TRCE before sort, tags: [("clone3", 100), ("clone4", 0)]
Oct 15 01:56:13.292 INFO blam! Oct 15 01:56:13.291 TRCE after sort, tags: [("clone4", 0), ("clone3", 100)]
Oct 15 01:56:13.292 INFO blam! Oct 15 01:56:13.291 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.291 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.291 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 15 01:56:13.293 INFO blam! Oct 15 01:56:13.291 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.293 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.293 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.293 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 15 01:56:13.293 INFO blam! Oct 15 01:56:13.292 TRCE before sort, tags: [("clone1", 50)]
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.292 TRCE after sort, tags: [("clone1", 50)]
Oct 15 01:56:13.293 INFO blam! test config::tests::test_repo_name_from_url ... ok
Oct 15 01:56:13.293 INFO blam! test config::tests::test_after_clone_from_tags_prioritized ... ok
Oct 15 01:56:13.293 INFO blam! test config::tests::test_after_clone_from_tags_missing_one_tag_graceful ... ok
Oct 15 01:56:13.293 INFO blam! test config::tests::test_do_expand_path ... ok
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.291 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.292 TRCE before sort, tags: []
Oct 15 01:56:13.293 INFO blam! Oct 15 01:56:13.292 TRCE after sort, tags: []
Oct 15 01:56:13.299 INFO blam! test config::tests::test_after_clone_from_tags_missing_all_tags_graceful ... ok
Oct 15 01:56:13.299 INFO blam! test config::tests::test_do_not_expand_path_without_tilde ... ok
Oct 15 01:56:13.299 INFO blam! test config::tests::test_repo_name_from_ssh_pragma ... ok
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.295 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.299 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.299 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.299 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 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 DEBG Writing projectile entry, entry: /home/mriehl/test
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.299 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.299 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.299 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 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE before sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE after sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE before sort, tags: []
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE after sort, tags: []
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 DEBG Writing projectile entry, entry: /home/mriehl/go/src/github.com/test2
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.296 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 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE before sort, tags: [("workon3", 100), ("workon4", 0)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.299 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.299 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.299 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 15 01:56:13.299 INFO blam! test config::tests::test_workon_from_tags ... ok
Oct 15 01:56:13.299 INFO blam! test config::tests::test_workon_from_tags_missing_all_tags_graceful ... ok
Oct 15 01:56:13.299 INFO blam! test projectile::tests::test_persists_projectile_config ... ok
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE before sort, tags: [("workon1", 50)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE after sort, tags: [("workon1", 50)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE Resolving, tags: Some({"tag1"})
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 DEBG No tag priority set, will use default (50).
Oct 15 01:56:13.299 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:13.299 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:13.299 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 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE after sort, tags: [("workon4", 0), ("workon3", 100)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE before sort, tags: [("workon1", 50)]
Oct 15 01:56:13.299 INFO blam! Oct 15 01:56:13.297 TRCE after sort, tags: [("workon1", 50)]
Oct 15 01:56:13.299 INFO blam! test config::tests::test_workon_from_tags_missing_one_tag_graceful ... ok
Oct 15 01:56:13.299 INFO blam! test config::tests::test_workon_from_tags_prioritized ... ok
Oct 15 01:56:13.299 INFO blam! test config::tests::test_workon_override_from_project ... ok
Oct 15 01:56:13.299 INFO blam! test export::tests::test_workon_override_from_project ... ok
Oct 15 01:56:13.307 INFO blam! test projectile::tests::test_replace_path_with_tilde ... ok
Oct 15 01:56:13.343 INFO blam! test sync::tests::test_username_from_git_url ... ok
Oct 15 01:56:13.343 INFO blam! 
Oct 15 01:56:13.343 INFO blam! test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 01:56:13.343 INFO blam! 
Oct 15 01:56:13.347 INFO kablam! su: No module specific data is present
Oct 15 01:56:14.647 INFO running `"docker" "rm" "-f" "5ecd92cbb05dd0b7d7dd713b5fc98058e79c20c61548b0a6ee1d2c07d190203d"`
Oct 15 01:56:14.859 INFO blam! 5ecd92cbb05dd0b7d7dd713b5fc98058e79c20c61548b0a6ee1d2c07d190203d