Oct 11 01:50:02.342 INFO testing brocode/fw against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 01:50:02.342 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 01:50:02.343 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-2/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 01:50:02.750 INFO blam! 9d8b7d7c4183dc6a6f2f60e6cf1f358a31a819a81817aaec8ca74f95d4d3b3ec
Oct 11 01:50:02.754 INFO running `"docker" "start" "-a" "9d8b7d7c4183dc6a6f2f60e6cf1f358a31a819a81817aaec8ca74f95d4d3b3ec"`
Oct 11 01:50:03.916 INFO kablam! usermod: no changes
Oct 11 01:50:04.408 INFO kablam!    Compiling slog v2.3.2
Oct 11 01:50:04.409 INFO kablam!    Compiling log v0.4.4
Oct 11 01:50:04.409 INFO kablam!    Compiling isatty v0.1.8
Oct 11 01:50:04.409 INFO kablam!    Compiling libz-sys v1.0.20
Oct 11 01:50:04.416 INFO kablam!    Compiling openssl-sys v0.9.35
Oct 11 01:50:04.417 INFO kablam!    Compiling cmake v0.1.33
Oct 11 01:50:04.417 INFO kablam!    Compiling curl-sys v0.4.8
Oct 11 01:50:04.422 INFO kablam!    Compiling parking_lot_core v0.2.14
Oct 11 01:50:06.208 INFO kablam!    Compiling backtrace-sys v0.1.24
Oct 11 01:50:13.924 INFO kablam!    Compiling num-bigint v0.1.44
Oct 11 01:50:13.933 INFO kablam!    Compiling chrono v0.4.5
Oct 11 01:50:14.844 INFO kablam!    Compiling backtrace v0.3.9
Oct 11 01:50:14.872 INFO kablam!    Compiling mio v0.6.15
Oct 11 01:50:14.912 INFO kablam!    Compiling tokio-io v0.1.7
Oct 11 01:50:15.040 INFO kablam!    Compiling log v0.3.9
Oct 11 01:50:15.696 INFO kablam!    Compiling want v0.0.4
Oct 11 01:50:16.388 INFO kablam!    Compiling libssh2-sys v0.2.10
Oct 11 01:50:21.646 INFO kablam!    Compiling libgit2-sys v0.7.7
Oct 11 01:50:21.649 INFO kablam!    Compiling crossbeam-deque v0.3.1
Oct 11 01:50:21.734 INFO kablam!    Compiling regex v0.2.11
Oct 11 01:50:29.264 INFO kablam!    Compiling slog-async v2.3.0
Oct 11 01:50:29.417 INFO kablam!    Compiling regex v1.0.2
Oct 11 01:50:29.496 INFO kablam!    Compiling crossbeam-deque v0.5.2
Oct 11 01:50:29.621 INFO kablam!    Compiling parking_lot v0.6.3
Oct 11 01:50:30.057 INFO kablam!    Compiling error-chain v0.11.0
Oct 11 01:50:32.252 INFO kablam!    Compiling error-chain v0.12.0
Oct 11 01:50:32.420 INFO kablam!    Compiling tokio-codec v0.1.0
Oct 11 01:50:40.204 INFO kablam!    Compiling slog-term v2.4.0
Oct 11 01:50:40.204 INFO kablam!    Compiling tokio-threadpool v0.1.5
Oct 11 01:50:40.232 INFO kablam!    Compiling tokio-reactor v0.1.3
Oct 11 01:50:45.616 INFO kablam!    Compiling num-rational v0.1.42
Oct 11 01:51:01.923 INFO kablam!    Compiling crossbeam-channel v0.2.4
Oct 11 01:51:02.557 INFO kablam!    Compiling tokio-udp v0.1.1
Oct 11 01:51:02.587 INFO kablam!    Compiling tokio-tcp v0.1.1
Oct 11 01:51:02.619 INFO kablam!    Compiling num v0.1.42
Oct 11 01:51:02.928 INFO kablam!    Compiling tokio-fs v0.1.3
Oct 11 01:51:03.301 INFO kablam!    Compiling console v0.6.1
Oct 11 01:51:12.445 INFO kablam!    Compiling spectral v0.6.0
Oct 11 01:51:12.480 INFO kablam!    Compiling indicatif v0.9.0
Oct 11 01:51:12.481 INFO kablam!    Compiling rustls v0.11.0
Oct 11 01:51:14.256 INFO kablam!    Compiling tokio v0.1.7
Oct 11 01:51:16.033 INFO kablam!    Compiling crossbeam v0.4.1
Oct 11 01:51:27.961 INFO kablam!    Compiling tokio-core v0.1.17
Oct 11 01:51:42.172 INFO kablam!    Compiling tokio-proto v0.1.1
Oct 11 01:51:50.436 INFO kablam!    Compiling git2 v0.7.5
Oct 11 01:51:51.932 INFO kablam!    Compiling hyper v0.11.27
Oct 11 01:51:51.932 INFO kablam!    Compiling tokio-rustls v0.4.0
Oct 11 01:52:08.275 INFO kablam!    Compiling hyper-rustls v0.11.0
Oct 11 01:52:13.920 INFO kablam!    Compiling github-gql-rs v0.0.1
Oct 11 01:52:20.296 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 11 01:52:48.666 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2m 44s
Oct 11 01:52:48.692 INFO kablam! su: No module specific data is present
Oct 11 01:52:49.285 INFO running `"docker" "rm" "-f" "9d8b7d7c4183dc6a6f2f60e6cf1f358a31a819a81817aaec8ca74f95d4d3b3ec"`
Oct 11 01:52:49.648 INFO blam! 9d8b7d7c4183dc6a6f2f60e6cf1f358a31a819a81817aaec8ca74f95d4d3b3ec
Oct 11 01:52:49.656 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 01:52:49.656 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-2/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 01:52:50.129 INFO blam! 8226a9ce520a2466b366114044be920e79b364de611d07473b9a32b6510fd073
Oct 11 01:52:50.131 INFO running `"docker" "start" "-a" "8226a9ce520a2466b366114044be920e79b364de611d07473b9a32b6510fd073"`
Oct 11 01:52:51.828 INFO kablam! usermod: no changes
Oct 11 01:52:52.368 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 11 01:53:12.036 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 20.19s
Oct 11 01:53:12.062 INFO kablam! su: No module specific data is present
Oct 11 01:53:12.512 INFO running `"docker" "rm" "-f" "8226a9ce520a2466b366114044be920e79b364de611d07473b9a32b6510fd073"`
Oct 11 01:53:12.907 INFO blam! 8226a9ce520a2466b366114044be920e79b364de611d07473b9a32b6510fd073
Oct 11 01:53:12.912 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 01:53:12.913 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-2/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 01:53:13.307 INFO blam! 5a4c4400532e561a42d236576152fdfef843859e45793356fd1f5fdaf999289a
Oct 11 01:53:13.310 INFO running `"docker" "start" "-a" "5a4c4400532e561a42d236576152fdfef843859e45793356fd1f5fdaf999289a"`
Oct 11 01:53:14.560 INFO kablam! usermod: no changes
Oct 11 01:53:14.904 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.29s
Oct 11 01:53:14.923 INFO kablam!      Running /target/debug/deps/fw-00e9b4e51a659fd8
Oct 11 01:53:14.968 INFO blam! 
Oct 11 01:53:14.968 INFO blam! running 19 tests
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.988 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.988 DEBG No tag priority set, will use default (50).
Oct 11 01:53:14.992 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:14.992 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:14.992 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 11 01:53:14.992 INFO blam! Oct 11 01:53:14.988 DEBG No tag priority set, will use default (50).
Oct 11 01:53:14.992 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:14.992 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:14.992 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 11 01:53:14.992 INFO blam! Oct 11 01:53:14.988 TRCE before sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.989 TRCE after sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 11 01:53:14.992 INFO blam! test config::tests::test_after_clone_from_tags ... ok
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.989 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.989 TRCE before sort, tags: [("clone3", 100), ("clone4", 0)]
Oct 11 01:53:14.992 INFO blam! Oct 11 01:53:14.989 TRCE after sort, tags: [("clone4", 0), ("clone3", 100)]
Oct 11 01:53:14.992 INFO blam! test config::tests::test_after_clone_from_tags_prioritized ... ok
Oct 11 01:53:14.996 INFO blam! Oct 11 01:53:14.995 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 11 01:53:14.996 INFO blam! Oct 11 01:53:14.996 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 11 01:53:14.996 INFO blam! Oct 11 01:53:14.996 TRCE before sort, tags: []
Oct 11 01:53:14.996 INFO blam! Oct 11 01:53:14.996 TRCE after sort, tags: []
Oct 11 01:53:14.996 INFO blam! Oct 11 01:53:14.995 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 11 01:53:14.996 INFO blam! test config::tests::test_do_expand_path ... ok
Oct 11 01:53:14.996 INFO blam! test config::tests::test_repo_name_from_ssh_pragma_with_multiple_git_endings ... ok
Oct 11 01:53:15.000 INFO blam! test config::tests::test_after_clone_from_tags_missing_all_tags_graceful ... ok
Oct 11 01:53:15.000 INFO blam! Oct 11 01:53:14.996 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 11 01:53:15.000 INFO blam! Oct 11 01:53:14.996 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.000 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.000 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.000 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 11 01:53:15.000 INFO blam! Oct 11 01:53:14.996 TRCE before sort, tags: [("clone1", 50)]
Oct 11 01:53:15.000 INFO blam! Oct 11 01:53:14.996 TRCE after sort, tags: [("clone1", 50)]
Oct 11 01:53:15.000 INFO blam! test config::tests::test_repo_name_from_ssh_pragma ... ok
Oct 11 01:53:15.000 INFO blam! test config::tests::test_after_clone_from_tags_missing_one_tag_graceful ... ok
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.004 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.004 TRCE before sort, tags: [("workon3", 100), ("workon4", 0)]
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.004 TRCE after sort, tags: [("workon4", 0), ("workon3", 100)]
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE Resolving, tags: Some({"tag1"})
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE Resolving, tags: Some({"tag1"})
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.012 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.012 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.012 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 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.012 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.012 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.012 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 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE before sort, tags: [("workon1", 50)]
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE before sort, tags: [("clone1", 50)]
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE after sort, tags: [("workon1", 50)]
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.008 TRCE after sort, tags: [("clone1", 50)]
Oct 11 01:53:15.012 INFO blam! test config::tests::test_do_not_expand_path_without_tilde ... ok
Oct 11 01:53:15.012 INFO blam! test config::tests::test_workon_from_tags_prioritized ... ok
Oct 11 01:53:15.012 INFO blam! test config::tests::test_workon_override_from_project ... ok
Oct 11 01:53:15.012 INFO blam! test config::tests::test_after_clone_override_from_project ... ok
Oct 11 01:53:15.012 INFO blam! test config::tests::test_repo_name_from_url ... ok
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.010 DEBG Writing projectile entry, entry: /home/mriehl/test
Oct 11 01:53:15.012 INFO blam! Oct 11 01:53:15.011 DEBG Writing projectile entry, entry: /home/mriehl/go/src/github.com/test2
Oct 11 01:53:15.017 INFO blam! test export::tests::test_workon_override_from_project ... ok
Oct 11 01:53:15.017 INFO blam! test projectile::tests::test_persists_projectile_config ... ok
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.012 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 11 01:53:15.017 INFO blam! test projectile::tests::test_replace_path_with_tilde ... ok
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.016 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.016 WARN Ignoring tag since it was not found in the config, missing_tag: tag-does-not-exist, tags: Some({"tag-does-not-exist"})
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.016 TRCE before sort, tags: []
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.016 TRCE after sort, tags: []
Oct 11 01:53:15.017 INFO blam! Oct 11 01:53:15.012 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 11 01:53:15.017 INFO blam! Oct 11 01:53:15.016 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.018 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.018 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.018 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 11 01:53:15.018 INFO blam! Oct 11 01:53:15.017 TRCE before sort, tags: [("workon1", 50)]
Oct 11 01:53:15.018 INFO blam! Oct 11 01:53:15.017 TRCE after sort, tags: [("workon1", 50)]
Oct 11 01:53:15.021 INFO blam! Oct 11 01:53:15.020 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 11 01:53:15.021 INFO blam! Oct 11 01:53:15.020 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.021 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.021 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.021 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 11 01:53:15.021 INFO blam! Oct 11 01:53:15.020 DEBG No tag priority set, will use default (50).
Oct 11 01:53:15.021 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 11 01:53:15.021 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 11 01:53:15.021 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 11 01:53:15.021 INFO blam! Oct 11 01:53:15.020 TRCE before sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 11 01:53:15.021 INFO blam! Oct 11 01:53:15.020 TRCE after sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 11 01:53:15.040 INFO blam! test config::tests::test_workon_from_tags_missing_all_tags_graceful ... ok
Oct 11 01:53:15.040 INFO blam! test config::tests::test_workon_from_tags_missing_one_tag_graceful ... ok
Oct 11 01:53:15.040 INFO blam! test config::tests::test_workon_from_tags ... ok
Oct 11 01:53:15.096 INFO blam! test sync::tests::test_username_from_git_url ... ok
Oct 11 01:53:15.096 INFO blam! 
Oct 11 01:53:15.096 INFO blam! test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 01:53:15.096 INFO blam! 
Oct 11 01:53:15.100 INFO kablam! su: No module specific data is present
Oct 11 01:53:16.288 INFO running `"docker" "rm" "-f" "5a4c4400532e561a42d236576152fdfef843859e45793356fd1f5fdaf999289a"`
Oct 11 01:53:16.677 INFO blam! 5a4c4400532e561a42d236576152fdfef843859e45793356fd1f5fdaf999289a