Oct 13 01:58:35.118 INFO testing rust-lang-nursery/crater against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 13 01:58:35.118 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 13 01:58:35.592 INFO blam! 0b860bb9c5ebc47a302242d902953b94e723cb5552b089f8d3f21f14eb46634b
Oct 13 01:58:35.597 INFO running `"docker" "start" "-a" "0b860bb9c5ebc47a302242d902953b94e723cb5552b089f8d3f21f14eb46634b"`
Oct 13 01:58:36.815 INFO kablam! usermod: no changes
Oct 13 01:58:37.471 INFO kablam!    Compiling unic-common v0.7.0
Oct 13 01:58:37.471 INFO kablam!    Compiling unic-char-range v0.7.0
Oct 13 01:58:37.471 INFO kablam!    Compiling deunicode v0.4.3
Oct 13 01:58:37.471 INFO kablam!    Compiling winapi v0.3.5
Oct 13 01:58:37.471 INFO kablam!    Compiling slog v2.3.3
Oct 13 01:58:37.471 INFO kablam!    Compiling humansize v1.1.0
Oct 13 01:58:37.471 INFO kablam!    Compiling crater v0.1.0 (/source)
Oct 13 01:58:37.471 INFO kablam!    Compiling macro-utils v0.1.2
Oct 13 01:58:38.798 INFO kablam!    Compiling ref_slice v1.1.1
Oct 13 01:58:38.803 INFO kablam!    Compiling dirs v1.0.4
Oct 13 01:58:38.830 INFO kablam!    Compiling xattr v0.2.2
Oct 13 01:58:40.315 INFO kablam!    Compiling isatty v0.1.9
Oct 13 01:58:41.320 INFO kablam!    Compiling filetime v0.2.1
Oct 13 01:58:44.062 INFO kablam!    Compiling libz-sys v1.0.22
Oct 13 01:58:44.064 INFO kablam!    Compiling curl-sys v0.4.10
Oct 13 01:58:44.088 INFO kablam!    Compiling libgit2-sys v0.7.8
Oct 13 01:58:44.139 INFO kablam!    Compiling libsqlite3-sys v0.9.3
Oct 13 01:58:44.139 INFO kablam!    Compiling tokio-service v0.1.0
Oct 13 01:58:44.179 INFO kablam!    Compiling relay v0.1.1
Oct 13 01:58:46.327 INFO kablam!    Compiling xml-rs v0.7.0
Oct 13 01:58:46.375 INFO kablam!    Compiling petgraph v0.4.13
Oct 13 01:58:46.399 INFO kablam!    Compiling tokio-timer v0.1.2
Oct 13 01:58:46.611 INFO kablam!    Compiling unic-ucd-version v0.7.0
Oct 13 01:58:47.091 INFO kablam!    Compiling aho-corasick v0.6.8
Oct 13 01:58:49.608 INFO kablam!    Compiling csv-core v0.1.4
Oct 13 01:58:53.057 INFO kablam!    Compiling unic-char-property v0.7.0
Oct 13 01:58:53.110 INFO kablam!    Compiling tempdir v0.3.7
Oct 13 01:58:53.111 INFO kablam!    Compiling lock_api v0.1.3
Oct 13 01:58:53.188 INFO kablam!    Compiling tempfile v3.0.4
Oct 13 01:58:53.292 INFO kablam!    Compiling want v0.0.4
Oct 13 01:58:54.465 INFO kablam!    Compiling slug v0.1.4
Oct 13 01:58:57.688 INFO kablam!    Compiling slog-scope v4.0.1
Oct 13 01:58:58.364 INFO kablam!    Compiling r2d2 v0.8.2
Oct 13 01:58:58.365 INFO kablam!    Compiling nix v0.11.0
Oct 13 01:58:58.367 INFO kablam!    Compiling tar v0.4.16
Oct 13 01:58:58.485 INFO kablam!    Compiling rusoto_core v0.34.0
Oct 13 01:59:05.016 INFO kablam!    Compiling input_buffer v0.2.0
Oct 13 01:59:05.653 INFO kablam!    Compiling unic-ucd-segment v0.7.0
Oct 13 01:59:05.732 INFO kablam! warning: failed to get crater sha
Oct 13 01:59:05.732 INFO kablam!    Compiling csv v1.0.2
Oct 13 01:59:09.223 INFO kablam!    Compiling crossbeam-epoch v0.5.2
Oct 13 01:59:09.424 INFO kablam!    Compiling ring v0.13.2
Oct 13 01:59:18.804 INFO kablam!    Compiling libssh2-sys v0.2.11
Oct 13 01:59:19.041 INFO kablam!    Compiling openssl v0.9.24
Oct 13 01:59:21.543 INFO kablam!    Compiling flate2 v1.0.2
Oct 13 01:59:21.575 INFO kablam!    Compiling chrono v0.4.6
Oct 13 01:59:21.681 INFO kablam!    Compiling regex v0.2.11
Oct 13 01:59:32.511 INFO kablam!    Compiling regex v1.0.5
Oct 13 01:59:40.468 INFO kablam!    Compiling unic-segment v0.7.0
Oct 13 01:59:40.796 INFO kablam!    Compiling crossbeam-deque v0.6.1
Oct 13 01:59:43.832 INFO kablam!    Compiling error-chain v0.11.0
Oct 13 02:00:14.164 INFO kablam!    Compiling structopt-derive v0.2.10
Oct 13 02:00:14.441 INFO kablam!    Compiling sha2 v0.7.1
Oct 13 02:00:14.623 INFO kablam!    Compiling sha-1 v0.7.0
Oct 13 02:00:14.777 INFO kablam!    Compiling parking_lot v0.6.4
Oct 13 02:00:14.945 INFO kablam!    Compiling slog-term v2.4.0
Oct 13 02:00:15.085 INFO kablam!    Compiling chrono-humanize v0.0.11
Oct 13 02:00:17.731 INFO kablam!    Compiling tokio-threadpool v0.1.6
Oct 13 02:00:21.975 INFO kablam!    Compiling native-tls v0.1.5
Oct 13 02:00:21.991 INFO kablam!    Compiling tera v0.11.16
Oct 13 02:00:22.149 INFO kablam!    Compiling minifier v0.0.19
Oct 13 02:00:35.520 INFO kablam!    Compiling serde_regex v0.3.0
Oct 13 02:00:35.639 INFO kablam!    Compiling tungstenite v0.6.0
Oct 13 02:00:35.719 INFO kablam!    Compiling failure v0.1.2
Oct 13 02:00:35.719 INFO kablam!    Compiling tokio-reactor v0.1.5
Oct 13 02:00:35.995 INFO kablam!    Compiling rusqlite v0.14.0
Oct 13 02:00:38.863 INFO kablam!    Compiling tokio-fs v0.1.3
Oct 13 02:00:40.984 INFO kablam!    Compiling structopt v0.2.10
Oct 13 02:00:41.747 INFO kablam!    Compiling dotenv v0.13.0
Oct 13 02:00:51.071 INFO kablam!    Compiling tokio-uds v0.2.1
Oct 13 02:00:51.663 INFO kablam!    Compiling tokio-udp v0.1.2
Oct 13 02:00:51.663 INFO kablam!    Compiling tokio-tcp v0.1.1
Oct 13 02:00:52.221 INFO kablam!    Compiling r2d2_sqlite v0.6.0
Oct 13 02:00:58.113 INFO kablam!    Compiling tokio v0.1.8
Oct 13 02:01:05.475 INFO kablam!    Compiling tokio-core v0.1.17
Oct 13 02:01:05.475 INFO kablam!    Compiling hyper v0.12.10
Oct 13 02:01:23.127 INFO kablam!    Compiling hyper v0.11.27
Oct 13 02:01:23.127 INFO kablam!    Compiling tokio-tls v0.1.4
Oct 13 02:01:23.127 INFO kablam!    Compiling tokio-signal v0.1.5
Oct 13 02:01:28.811 INFO kablam!    Compiling tokio-process v0.1.6
Oct 13 02:01:39.808 INFO kablam!    Compiling rusoto_credential v0.13.0
Oct 13 02:01:39.808 INFO kablam!    Compiling hyper-tls v0.3.0
Oct 13 02:01:39.810 INFO kablam!    Compiling warp v0.1.3
Oct 13 02:02:06.764 INFO kablam!    Compiling hyper-tls v0.1.4
Oct 13 02:02:11.932 INFO kablam!    Compiling reqwest v0.8.8
Oct 13 02:02:15.416 INFO kablam!    Compiling git2 v0.7.5
Oct 13 02:02:31.709 INFO kablam!    Compiling rusoto_s3 v0.34.0
Oct 13 02:02:46.102 INFO kablam!    Compiling crates-index v0.12.0
Oct 13 02:04:46.661 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 6m 09s
Oct 13 02:04:46.691 INFO kablam! su: No module specific data is present
Oct 13 02:04:47.651 INFO running `"docker" "rm" "-f" "0b860bb9c5ebc47a302242d902953b94e723cb5552b089f8d3f21f14eb46634b"`
Oct 13 02:04:47.937 INFO blam! 0b860bb9c5ebc47a302242d902953b94e723cb5552b089f8d3f21f14eb46634b
Oct 13 02:04:47.945 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 13 02:04:48.529 INFO blam! 4efb36446114ce2735fe288322ccbbba889cc4b9401825e895c7e35c82b7212d
Oct 13 02:04:48.531 INFO running `"docker" "start" "-a" "4efb36446114ce2735fe288322ccbbba889cc4b9401825e895c7e35c82b7212d"`
Oct 13 02:04:49.890 INFO kablam! usermod: no changes
Oct 13 02:04:50.681 INFO kablam! warning: failed to get crater sha
Oct 13 02:04:50.684 INFO kablam!    Compiling crater v0.1.0 (/source)
Oct 13 02:05:24.778 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 34.85s
Oct 13 02:05:24.810 INFO kablam! su: No module specific data is present
Oct 13 02:05:25.759 INFO running `"docker" "rm" "-f" "4efb36446114ce2735fe288322ccbbba889cc4b9401825e895c7e35c82b7212d"`
Oct 13 02:05:26.163 INFO blam! 4efb36446114ce2735fe288322ccbbba889cc4b9401825e895c7e35c82b7212d
Oct 13 02:05:26.167 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 13 02:05:26.828 INFO blam! 8bd6ae26c96aea4c2107185c786f02d9adc208144ad3f70b42db05f3f3a99721
Oct 13 02:05:26.830 INFO running `"docker" "start" "-a" "8bd6ae26c96aea4c2107185c786f02d9adc208144ad3f70b42db05f3f3a99721"`
Oct 13 02:05:28.366 INFO kablam! usermod: no changes
Oct 13 02:05:28.814 INFO kablam! warning: failed to get crater sha
Oct 13 02:05:28.817 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.42s
Oct 13 02:05:28.845 INFO kablam!      Running /target/debug/deps/crater-f54401976696c04c
Oct 13 02:05:28.867 INFO blam! 
Oct 13 02:05:28.867 INFO blam! running 42 tests
Oct 13 02:05:29.489 INFO blam! test actions::experiments::delete::tests::test_delete_missing_experiment ... ok
Oct 13 02:05:29.535 INFO blam! test actions::experiments::create::tests::test_duplicate_toolchains ... ok
Oct 13 02:05:29.555 INFO blam! test actions::experiments::edit::tests::test_duplicate_toolchains ... ok
Oct 13 02:05:29.560 INFO blam! test actions::experiments::create::tests::test_duplicate_name ... ok
Oct 13 02:05:29.560 INFO blam! test actions::experiments::edit::tests::test_edit_with_no_changes ... ok
Oct 13 02:05:29.560 INFO blam! test config::tests::test_config ... ok
Oct 13 02:05:29.560 INFO blam! test actions::experiments::create::tests::test_creation ... ok
Oct 13 02:05:29.560 INFO blam! test experiments::tests::test_assignee_parsing ... ok
Oct 13 02:05:29.560 INFO blam! test native::unix::tests::test_current_user ... ok
Oct 13 02:05:29.561 INFO blam! test native::unix::tests::test_current_group ... ok
Oct 13 02:05:29.579 INFO blam! test native::unix::tests::test_make_executable ... ok
Oct 13 02:05:29.579 INFO blam! test native::unix::tests::test_kill_process ... ok
Oct 13 02:05:29.580 INFO blam! test report::s3::tests::test_parse_s3prefix ... ok
Oct 13 02:05:29.580 INFO blam! test report::tests::test_compare ... ok
Oct 13 02:05:29.584 INFO blam! test report::tests::test_crate_to_path_fragment ... ok
Oct 13 02:05:29.584 INFO blam! test report::tests::test_crate_to_name ... ok
Oct 13 02:05:29.587 INFO blam! test actions::experiments::delete::tests::test_delete_experiment ... ok
Oct 13 02:05:29.587 INFO blam! test report::tests::test_crate_to_url ... ok
Oct 13 02:05:29.614 INFO blam! test actions::experiments::edit::tests::test_edit_with_every_change ... ok
Oct 13 02:05:29.957 INFO blam! test actions::experiments::edit::tests::test_editing_missing_experiment ... ok
Oct 13 02:05:30.091 INFO blam! Oct 13 02:05:30.089 INFO tc1 crate1
Oct 13 02:05:30.105 INFO blam! Oct 13 02:05:30.104 INFO tc2 crate1
Oct 13 02:05:30.107 INFO blam! Oct 13 02:05:30.106 INFO hello world
Oct 13 02:05:30.109 INFO blam! test actions::experiments::edit::tests::test_editing_running_experiment ... ok
Oct 13 02:05:30.122 INFO blam! Oct 13 02:05:30.121 INFO tc1 crate2
Oct 13 02:05:30.128 INFO blam! Oct 13 02:05:30.128 INFO Another log message!
Oct 13 02:05:30.160 INFO blam! Oct 13 02:05:30.159 INFO tc2 crate2
Oct 13 02:05:30.193 INFO blam! test results::db::tests::test_shas ... ok
Oct 13 02:05:30.196 INFO blam! test report::archives::tests::test_logs_archives_generation ... ok
Oct 13 02:05:30.199 INFO blam! test server::auth::tests::test_parse_token ... ok
Oct 13 02:05:30.208 INFO blam! test server::routes::webhooks::args::tests::test_command_parsing ... ok
Oct 13 02:05:30.209 INFO blam! test results::db::tests::test_results ... ok
Oct 13 02:05:30.254 INFO blam! test results::db::tests::test_store ... ok
Oct 13 02:05:30.387 INFO blam! test server::agents::tests::test_agent_status ... ok
Oct 13 02:05:30.420 INFO blam! test server::agents::tests::test_agents_synchronize ... ok
Oct 13 02:05:30.427 INFO blam! test toml_frobber::tests::test_frob_table_changes ... ok
Oct 13 02:05:30.435 INFO blam! test toml_frobber::tests::test_frob_table_noop ... ok
Oct 13 02:05:30.435 INFO blam! test toolchain::tests::test_string_repr ... ok
Oct 13 02:05:30.435 INFO blam! test utils::hex::tests::test_from_hex ... ok
Oct 13 02:05:30.435 INFO blam! test utils::size::tests::test_size ... ok
Oct 13 02:05:30.435 INFO blam! test utils::string::tests::test_split_quoted ... ok
Oct 13 02:05:30.544 INFO blam! test server::routes::webhooks::commands::tests::test_default_experiment_name ... ok
Oct 13 02:05:30.566 INFO blam! test server::agents::tests::test_heartbeat_recording ... ok
Oct 13 02:05:30.624 INFO blam! test server::routes::webhooks::commands::tests::test_generate_new_experiment_name ... ok
Oct 13 02:05:30.631 INFO blam! test server::routes::webhooks::commands::tests::test_edit ... ok
Oct 13 02:05:30.943 INFO blam! test server::routes::webhooks::commands::tests::test_run ... ok
Oct 13 02:05:31.200 INFO blam! test report::tests::test_report_generation ... ok
Oct 13 02:05:31.374 INFO blam! test experiments::tests::test_assigning_experiment ... ok
Oct 13 02:05:31.374 INFO blam! 
Oct 13 02:05:31.374 INFO blam! test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 13 02:05:31.375 INFO blam! 
Oct 13 02:05:31.391 INFO blam! 
Oct 13 02:05:31.391 INFO kablam!      Running /target/debug/deps/crater-ab38dbbf475f8334
Oct 13 02:05:31.391 INFO blam! running 0 tests
Oct 13 02:05:31.391 INFO kablam!    Doc-tests crater
Oct 13 02:05:31.391 INFO blam! 
Oct 13 02:05:31.391 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 13 02:05:31.391 INFO blam! 
Oct 13 02:05:37.885 INFO blam! 
Oct 13 02:05:37.885 INFO blam! running 0 tests
Oct 13 02:05:37.885 INFO blam! 
Oct 13 02:05:37.885 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 13 02:05:37.885 INFO blam! 
Oct 13 02:05:37.906 INFO kablam! su: No module specific data is present
Oct 13 02:05:39.509 INFO running `"docker" "rm" "-f" "8bd6ae26c96aea4c2107185c786f02d9adc208144ad3f70b42db05f3f3a99721"`
Oct 13 02:05:39.808 INFO blam! 8bd6ae26c96aea4c2107185c786f02d9adc208144ad3f70b42db05f3f3a99721