Oct 15 01:52:44.675 INFO testing brocode/fw against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling-1
Oct 15 01:52:44.677 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-4/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-4/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:45.253 INFO blam! c6ee836417f18cd81c53d9038f9fe1b3559c512ad979cbefb1edbecf46e028cc
Oct 15 01:52:45.256 INFO running `"docker" "start" "-a" "c6ee836417f18cd81c53d9038f9fe1b3559c512ad979cbefb1edbecf46e028cc"`
Oct 15 01:52:47.799 INFO kablam! usermod: no changes
Oct 15 01:52:48.335 INFO kablam!    Compiling cc v1.0.19
Oct 15 01:52:48.360 INFO kablam!    Compiling serde v1.0.72
Oct 15 01:52:48.375 INFO kablam!    Compiling slog v2.3.2
Oct 15 01:52:48.377 INFO kablam!    Compiling termios v0.2.2
Oct 15 01:52:48.388 INFO kablam!    Compiling isatty v0.1.8
Oct 15 01:52:48.389 INFO kablam!    Compiling dirs v1.0.3
Oct 15 01:52:48.393 INFO kablam!    Compiling ryu v0.2.4
Oct 15 01:52:48.393 INFO kablam!    Compiling num-complex v0.1.43
Oct 15 01:52:50.607 INFO kablam!    Compiling parking_lot_core v0.2.14
Oct 15 01:52:54.055 INFO kablam!    Compiling num-bigint v0.1.44
Oct 15 01:52:54.115 INFO kablam!    Compiling chrono v0.4.5
Oct 15 01:52:54.188 INFO kablam!    Compiling syn v0.14.9
Oct 15 01:52:55.151 INFO kablam!    Compiling crossbeam-deque v0.5.2
Oct 15 01:52:57.151 INFO kablam!    Compiling tokio-threadpool v0.1.5
Oct 15 01:52:57.195 INFO kablam!    Compiling slog-async v2.3.0
Oct 15 01:53:08.303 INFO kablam!    Compiling parking_lot v0.6.3
Oct 15 01:53:08.319 INFO kablam!    Compiling openssl-sys v0.9.35
Oct 15 01:53:08.379 INFO kablam!    Compiling libz-sys v1.0.20
Oct 15 01:53:21.280 INFO kablam!    Compiling cmake v0.1.33
Oct 15 01:53:21.352 INFO kablam!    Compiling backtrace-sys v0.1.24
Oct 15 01:53:21.512 INFO kablam!    Compiling curl-sys v0.4.8
Oct 15 01:53:21.660 INFO kablam!    Compiling ring v0.12.1
Oct 15 01:53:22.317 INFO kablam!    Compiling num-rational v0.1.42
Oct 15 01:53:23.613 INFO kablam!    Compiling crossbeam-channel v0.2.4
Oct 15 01:53:28.725 INFO kablam!    Compiling console v0.6.1
Oct 15 01:53:37.516 INFO kablam!    Compiling slog-term v2.4.0
Oct 15 01:53:37.713 INFO kablam!    Compiling tokio-fs v0.1.3
Oct 15 01:53:39.035 INFO kablam!    Compiling libssh2-sys v0.2.10
Oct 15 01:53:52.631 INFO kablam!    Compiling libgit2-sys v0.7.7
Oct 15 01:53:53.480 INFO kablam!    Compiling num v0.1.42
Oct 15 01:53:53.740 INFO kablam!    Compiling crossbeam v0.4.1
Oct 15 01:53:57.637 INFO kablam!    Compiling indicatif v0.9.0
Oct 15 01:53:58.020 INFO kablam!    Compiling tokio v0.1.7
Oct 15 01:53:59.691 INFO kablam!    Compiling serde_derive v1.0.72
Oct 15 01:54:03.345 INFO kablam!    Compiling backtrace v0.3.9
Oct 15 01:54:03.363 INFO kablam!    Compiling spectral v0.6.0
Oct 15 01:54:17.523 INFO kablam!    Compiling error-chain v0.11.0
Oct 15 01:54:17.707 INFO kablam!    Compiling error-chain v0.12.0
Oct 15 01:54:18.104 INFO kablam!    Compiling tokio-core v0.1.17
Oct 15 01:54:31.416 INFO kablam!    Compiling webpki v0.17.0
Oct 15 01:54:31.419 INFO kablam!    Compiling sct v0.2.0
Oct 15 01:54:36.175 INFO kablam!    Compiling ct-logs v0.2.0
Oct 15 01:54:36.640 INFO kablam!    Compiling tokio-proto v0.1.1
Oct 15 01:54:38.441 INFO kablam!    Compiling rustls v0.11.0
Oct 15 01:54:38.441 INFO kablam!    Compiling webpki-roots v0.13.0
Oct 15 01:54:40.130 INFO kablam!    Compiling serde_json v1.0.26
Oct 15 01:54:49.591 INFO kablam!    Compiling hyper v0.11.27
Oct 15 01:55:17.035 INFO kablam!    Compiling tokio-rustls v0.4.0
Oct 15 01:55:36.259 INFO kablam!    Compiling git2 v0.7.5
Oct 15 01:55:37.099 INFO kablam!    Compiling hyper-rustls v0.11.0
Oct 15 01:55:39.916 INFO kablam!    Compiling github-gql-rs v0.0.1
Oct 15 01:55:45.795 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 15 01:56:07.405 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 3m 19s
Oct 15 01:56:07.421 INFO kablam! su: No module specific data is present
Oct 15 01:56:07.708 INFO running `"docker" "rm" "-f" "c6ee836417f18cd81c53d9038f9fe1b3559c512ad979cbefb1edbecf46e028cc"`
Oct 15 01:56:07.803 INFO blam! c6ee836417f18cd81c53d9038f9fe1b3559c512ad979cbefb1edbecf46e028cc
Oct 15 01:56:07.811 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-4/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-4/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:56:07.998 INFO blam! d80281afca97dcd0f99c4a705dd3233483135e534db35fc2c87f6cbb7f76459f
Oct 15 01:56:07.999 INFO running `"docker" "start" "-a" "d80281afca97dcd0f99c4a705dd3233483135e534db35fc2c87f6cbb7f76459f"`
Oct 15 01:56:08.515 INFO kablam! usermod: no changes
Oct 15 01:56:08.747 INFO kablam!    Compiling fw v1.11.1-alpha.0 (/source)
Oct 15 01:56:20.751 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 12.22s
Oct 15 01:56:20.772 INFO kablam! su: No module specific data is present
Oct 15 01:56:21.567 INFO running `"docker" "rm" "-f" "d80281afca97dcd0f99c4a705dd3233483135e534db35fc2c87f6cbb7f76459f"`
Oct 15 01:56:21.819 INFO blam! d80281afca97dcd0f99c4a705dd3233483135e534db35fc2c87f6cbb7f76459f
Oct 15 01:56:21.830 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-4/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-4/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:22.219 INFO blam! 1acad5aa02b69416f327b9d450b07fb4eeb40da82699518c6b02dadc0e4014e4
Oct 15 01:56:22.224 INFO running `"docker" "start" "-a" "1acad5aa02b69416f327b9d450b07fb4eeb40da82699518c6b02dadc0e4014e4"`
Oct 15 01:56:23.455 INFO kablam! usermod: no changes
Oct 15 01:56:23.723 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Oct 15 01:56:23.753 INFO kablam!      Running /target/debug/deps/fw-00e9b4e51a659fd8
Oct 15 01:56:23.771 INFO blam! 
Oct 15 01:56:23.771 INFO blam! running 19 tests
Oct 15 01:56:23.799 INFO blam! Oct 15 01:56:23.795 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:23.799 INFO blam! Oct 15 01:56:23.795 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:23.799 INFO blam! Oct 15 01:56:23.795 TRCE before sort, tags: []
Oct 15 01:56:23.799 INFO blam! Oct 15 01:56:23.795 TRCE after sort, tags: []
Oct 15 01:56:23.804 INFO blam! Oct 15 01:56:23.799 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 15 01:56:23.804 INFO blam! Oct 15 01:56:23.799 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:23.804 INFO blam! Oct 15 01:56:23.799 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.805 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.805 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.805 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:23.805 INFO blam! Oct 15 01:56:23.799 TRCE before sort, tags: [("clone1", 50)]
Oct 15 01:56:23.806 INFO blam! Oct 15 01:56:23.799 TRCE after sort, tags: [("clone1", 50)]
Oct 15 01:56:23.806 INFO blam! Oct 15 01:56:23.800 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 15 01:56:23.806 INFO blam! Oct 15 01:56:23.800 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.807 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.807 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.807 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:23.807 INFO blam! Oct 15 01:56:23.800 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.808 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.808 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.808 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:23.809 INFO blam! Oct 15 01:56:23.800 TRCE before sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 15 01:56:23.809 INFO blam! Oct 15 01:56:23.800 TRCE after sort, tags: [("clone1", 50), ("clone2", 50)]
Oct 15 01:56:23.809 INFO blam! test config::tests::test_after_clone_from_tags_missing_all_tags_graceful ... ok
Oct 15 01:56:23.809 INFO blam! test config::tests::test_after_clone_from_tags_missing_one_tag_graceful ... ok
Oct 15 01:56:23.810 INFO blam! test config::tests::test_after_clone_from_tags ... ok
Oct 15 01:56:23.810 INFO blam! Oct 15 01:56:23.800 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 15 01:56:23.810 INFO blam! Oct 15 01:56:23.800 TRCE before sort, tags: [("clone3", 100), ("clone4", 0)]
Oct 15 01:56:23.811 INFO blam! Oct 15 01:56:23.800 TRCE after sort, tags: [("clone4", 0), ("clone3", 100)]
Oct 15 01:56:23.811 INFO blam! test config::tests::test_after_clone_from_tags_prioritized ... ok
Oct 15 01:56:23.811 INFO blam! test config::tests::test_do_expand_path ... ok
Oct 15 01:56:23.811 INFO blam! Oct 15 01:56:23.801 TRCE Resolving, tags: Some({"tag1"})
Oct 15 01:56:23.812 INFO blam! Oct 15 01:56:23.801 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.812 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.812 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.812 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:23.813 INFO blam! Oct 15 01:56:23.801 TRCE before sort, tags: [("clone1", 50)]
Oct 15 01:56:23.813 INFO blam! Oct 15 01:56:23.801 TRCE after sort, tags: [("clone1", 50)]
Oct 15 01:56:23.813 INFO blam! test config::tests::test_after_clone_override_from_project ... ok
Oct 15 01:56:23.814 INFO blam! test config::tests::test_do_not_expand_path_without_tilde ... ok
Oct 15 01:56:23.814 INFO blam! Oct 15 01:56:23.801 TRCE Resolving, tags: Some({"tag3", "tag4"})
Oct 15 01:56:23.814 INFO blam! Oct 15 01:56:23.801 TRCE before sort, tags: [("workon3", 100), ("workon4", 0)]
Oct 15 01:56:23.814 INFO blam! Oct 15 01:56:23.801 TRCE after sort, tags: [("workon4", 0), ("workon3", 100)]
Oct 15 01:56:23.815 INFO blam! test config::tests::test_workon_from_tags_prioritized ... ok
Oct 15 01:56:23.815 INFO blam! Oct 15 01:56:23.802 TRCE Resolving, tags: Some({"tag1"})
Oct 15 01:56:23.815 INFO blam! Oct 15 01:56:23.802 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.816 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.816 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.816 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:23.816 INFO blam! Oct 15 01:56:23.802 TRCE before sort, tags: [("workon1", 50)]
Oct 15 01:56:23.816 INFO blam! Oct 15 01:56:23.802 TRCE after sort, tags: [("workon1", 50)]
Oct 15 01:56:23.816 INFO blam! test config::tests::test_workon_override_from_project ... ok
Oct 15 01:56:23.817 INFO blam! test export::tests::test_workon_override_from_project ... ok
Oct 15 01:56:23.817 INFO blam! Oct 15 01:56:23.802 TRCE Resolving, tags: Some({"tag-does-not-exist"})
Oct 15 01:56:23.817 INFO blam! Oct 15 01:56:23.803 TRCE Resolving, tags: Some({"tag1", "tag2"})
Oct 15 01:56:23.817 INFO blam! Oct 15 01:56:23.803 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:23.817 INFO blam! Oct 15 01:56:23.803 TRCE before sort, tags: []
Oct 15 01:56:23.817 INFO blam! Oct 15 01:56:23.803 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.817 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.817 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.817 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:23.817 INFO blam! Oct 15 01:56:23.803 TRCE after sort, tags: []
Oct 15 01:56:23.817 INFO blam! Oct 15 01:56:23.803 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.817 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.817 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.817 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:23.817 INFO blam! test config::tests::test_workon_from_tags_missing_all_tags_graceful ... ok
Oct 15 01:56:23.835 INFO blam! Oct 15 01:56:23.823 TRCE before sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 15 01:56:23.835 INFO blam! Oct 15 01:56:23.823 TRCE after sort, tags: [("workon1", 50), ("workon2", 50)]
Oct 15 01:56:23.835 INFO blam! test config::tests::test_workon_from_tags ... ok
Oct 15 01:56:23.835 INFO blam! test config::tests::test_repo_name_from_ssh_pragma_with_multiple_git_endings ... ok
Oct 15 01:56:23.839 INFO blam! test config::tests::test_repo_name_from_url ... ok
Oct 15 01:56:23.852 INFO blam! Oct 15 01:56:23.852 DEBG Writing projectile entry, entry: /home/mriehl/test
Oct 15 01:56:23.859 INFO blam! Oct 15 01:56:23.853 DEBG Writing projectile entry, entry: /home/mriehl/go/src/github.com/test2
Oct 15 01:56:23.859 INFO blam! Oct 15 01:56:23.853 TRCE Resolving, tags: Some({"tag-does-not-exist", "tag1"})
Oct 15 01:56:23.859 INFO blam! Oct 15 01:56:23.854 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:23.859 INFO blam! Oct 15 01:56:23.854 DEBG No tag priority set, will use default (50).
Oct 15 01:56:23.859 INFO blam! Tags with low priority are applied first and if they all have the same priority
Oct 15 01:56:23.859 INFO blam! they will be applied in alphabetical name order so it is recommended you make a
Oct 15 01:56:23.859 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:23.859 INFO blam! Oct 15 01:56:23.854 TRCE before sort, tags: [("workon1", 50)]
Oct 15 01:56:23.859 INFO blam! Oct 15 01:56:23.854 TRCE after sort, tags: [("workon1", 50)]
Oct 15 01:56:23.859 INFO blam! test projectile::tests::test_persists_projectile_config ... ok
Oct 15 01:56:23.859 INFO blam! test config::tests::test_workon_from_tags_missing_one_tag_graceful ... ok
Oct 15 01:56:23.860 INFO blam! test config::tests::test_repo_name_from_ssh_pragma ... ok
Oct 15 01:56:23.861 INFO blam! test projectile::tests::test_replace_path_with_tilde ... ok
Oct 15 01:56:23.959 INFO blam! test sync::tests::test_username_from_git_url ... ok
Oct 15 01:56:23.959 INFO blam! 
Oct 15 01:56:23.959 INFO blam! test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 01:56:23.959 INFO blam! 
Oct 15 01:56:23.967 INFO kablam! su: No module specific data is present
Oct 15 01:56:24.697 INFO running `"docker" "rm" "-f" "1acad5aa02b69416f327b9d450b07fb4eeb40da82699518c6b02dadc0e4014e4"`
Oct 15 01:56:24.967 INFO blam! 1acad5aa02b69416f327b9d450b07fb4eeb40da82699518c6b02dadc0e4014e4