Oct 11 19:50:07.698 INFO testing gotham-0.2.1 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 11 19:50:07.698 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 11 19:50:07.698 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 19:50:07.888 INFO blam! 12a44ea8ac7613d4742049221fc92f2273270eb2070f6f500ff0331eeffc0fb6 Oct 11 19:50:07.888 INFO running `"docker" "start" "-a" "12a44ea8ac7613d4742049221fc92f2273270eb2070f6f500ff0331eeffc0fb6"` Oct 11 19:50:08.481 INFO kablam! usermod: no changes Oct 11 19:50:08.836 INFO kablam! Compiling bincode v1.0.1 Oct 11 19:50:08.836 INFO kablam! Compiling parking_lot_core v0.3.1 Oct 11 19:50:08.836 INFO kablam! Compiling borrow-bag v1.0.0 Oct 11 19:50:11.804 INFO kablam! Compiling parking_lot v0.6.4 Oct 11 19:50:14.315 INFO kablam! Compiling tokio-reactor v0.1.6 Oct 11 19:50:18.776 INFO kablam! Compiling tokio-uds v0.2.2 Oct 11 19:50:18.776 INFO kablam! Compiling tokio-udp v0.1.2 Oct 11 19:50:18.776 INFO kablam! Compiling tokio-tcp v0.1.2 Oct 11 19:50:24.116 INFO kablam! Compiling tokio v0.1.11 Oct 11 19:50:29.052 INFO kablam! Compiling tokio-core v0.1.17 Oct 11 19:50:35.055 INFO kablam! Compiling tokio-proto v0.1.1 Oct 11 19:50:41.015 INFO kablam! Compiling hyper v0.11.27 Oct 11 19:50:54.720 INFO kablam! Compiling gotham v0.2.1 (/source) Oct 11 19:51:03.304 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 11 19:51:03.304 INFO kablam! --> src/http/header/x_frame_options.rs:7:5 Oct 11 19:51:03.304 INFO kablam! | Oct 11 19:51:03.304 INFO kablam! 7 | use std::ascii::AsciiExt; Oct 11 19:51:03.304 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 11 19:51:03.304 INFO kablam! | Oct 11 19:51:03.304 INFO kablam! note: lint level defined here Oct 11 19:51:03.304 INFO kablam! --> src/lib.rs:7:23 Oct 11 19:51:03.304 INFO kablam! | Oct 11 19:51:03.304 INFO kablam! 7 | #![warn(missing_docs, deprecated)] Oct 11 19:51:03.304 INFO kablam! | ^^^^^^^^^^ Oct 11 19:51:03.304 INFO kablam! Oct 11 19:51:03.304 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 11 19:51:03.304 INFO kablam! --> src/http/header/x_content_type_options.rs:6:5 Oct 11 19:51:03.304 INFO kablam! | Oct 11 19:51:03.304 INFO kablam! 6 | use std::ascii::AsciiExt; Oct 11 19:51:03.304 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 11 19:51:03.304 INFO kablam! Oct 11 19:51:08.484 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 59.97s Oct 11 19:51:08.504 INFO kablam! su: No module specific data is present Oct 11 19:51:09.542 INFO running `"docker" "rm" "-f" "12a44ea8ac7613d4742049221fc92f2273270eb2070f6f500ff0331eeffc0fb6"` Oct 11 19:51:09.864 INFO blam! 12a44ea8ac7613d4742049221fc92f2273270eb2070f6f500ff0331eeffc0fb6 Oct 11 19:51:09.866 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 11 19:51:09.866 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 19:51:10.255 INFO blam! 1c3db84532ae9cc68f8f8a481d4788209898a0be8dbec7af14dbde68bbd225bd Oct 11 19:51:10.256 INFO running `"docker" "start" "-a" "1c3db84532ae9cc68f8f8a481d4788209898a0be8dbec7af14dbde68bbd225bd"` Oct 11 19:51:11.604 INFO kablam! usermod: no changes Oct 11 19:51:11.844 INFO kablam! Compiling gotham v0.2.1 (/source) Oct 11 19:51:19.684 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 11 19:51:19.684 INFO kablam! --> src/http/header/x_frame_options.rs:7:5 Oct 11 19:51:19.684 INFO kablam! | Oct 11 19:51:19.684 INFO kablam! 7 | use std::ascii::AsciiExt; Oct 11 19:51:19.684 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 11 19:51:19.684 INFO kablam! | Oct 11 19:51:19.684 INFO kablam! note: lint level defined here Oct 11 19:51:19.684 INFO kablam! --> src/lib.rs:7:23 Oct 11 19:51:19.684 INFO kablam! | Oct 11 19:51:19.684 INFO kablam! 7 | #![warn(missing_docs, deprecated)] Oct 11 19:51:19.684 INFO kablam! | ^^^^^^^^^^ Oct 11 19:51:19.684 INFO kablam! Oct 11 19:51:19.684 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 11 19:51:19.684 INFO kablam! --> src/http/header/x_content_type_options.rs:6:5 Oct 11 19:51:19.684 INFO kablam! | Oct 11 19:51:19.684 INFO kablam! 6 | use std::ascii::AsciiExt; Oct 11 19:51:19.684 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 11 19:51:19.684 INFO kablam! Oct 11 19:51:38.680 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 27.04s Oct 11 19:51:38.690 INFO kablam! su: No module specific data is present Oct 11 19:51:39.036 INFO running `"docker" "rm" "-f" "1c3db84532ae9cc68f8f8a481d4788209898a0be8dbec7af14dbde68bbd225bd"` Oct 11 19:51:39.148 INFO blam! 1c3db84532ae9cc68f8f8a481d4788209898a0be8dbec7af14dbde68bbd225bd Oct 11 19:51:39.153 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 11 19:51:39.154 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-5/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-5/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 19:51:39.450 INFO blam! 623458e13a1f332f0012e94754a761fb65885a050f7821324f3f1049afbc7ee2 Oct 11 19:51:39.453 INFO running `"docker" "start" "-a" "623458e13a1f332f0012e94754a761fb65885a050f7821324f3f1049afbc7ee2"` Oct 11 19:51:40.260 INFO kablam! usermod: no changes Oct 11 19:51:40.469 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.18s Oct 11 19:51:40.500 INFO kablam! Running /target/debug/deps/gotham-8e3e4b47eaf96172 Oct 11 19:51:40.501 INFO blam! Oct 11 19:51:40.501 INFO blam! running 82 tests Oct 11 19:51:40.502 INFO blam! test extractor::internal::tests::byte_buf_values_path_tests ... ok Oct 11 19:51:40.512 INFO blam! test extractor::internal::tests::borrowed_str_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::borrowed_str_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::newtype_struct_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::byte_buf_values_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::enum_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::borrowed_bytes_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::enum_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test http::header::tests::invalid_rws_from_one_header ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::borrowed_bytes_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::simple_values_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::simple_values_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::seq_path_tests ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::seq_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test http::header::tests::valid_rws_from_one_header ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_content_type_options::tests::parse_nosniff ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_content_type_options::tests::valid_display_formatting ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_frame_options::tests::parse_allow_from ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_frame_options::tests::parse_deny ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_frame_options::tests::parse_fails ... ok Oct 11 19:51:40.517 INFO blam! test extractor::internal::tests::newtype_struct_query_tests ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_xss_protection::tests::parse_enable ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_xss_protection::tests::parse_fails ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_content_type_options::tests::parse_fails ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_frame_options::tests::parse_same_origin ... ok Oct 11 19:51:40.517 INFO blam! test http::header::x_frame_options::tests::valid_display_formatting ... ok Oct 11 19:51:40.522 INFO blam! test http::tests::ensure_valid_www_form_url_encoded_value ... ok Oct 11 19:51:40.522 INFO blam! test middleware::session::backend::memory::tests::cleanup_join_test ... ok Oct 11 19:51:40.522 INFO blam! test http::request::query_string::tests::query_string_mapping_tests ... ok Oct 11 19:51:40.522 INFO blam! test http::request::path::tests::request_path_segments_tests ... ok Oct 11 19:51:40.522 INFO blam! test http::header::x_xss_protection::tests::valid_display_formatting ... ok Oct 11 19:51:40.522 INFO blam! test http::tests::ensure_valid_percent_decode ... ok Oct 11 19:51:40.522 INFO blam! test middleware::session::backend::memory::tests::cleanup_test ... ok Oct 11 19:51:40.524 INFO blam! test middleware::session::backend::memory::tests::memory_backend_test ... ok Oct 11 19:51:40.524 INFO blam! test middleware::session::tests::enforce_host_cookie_prefix_attributes ... ok Oct 11 19:51:40.531 INFO blam! test middleware::session::tests::enforce_secure_cookie_prefix_attributes ... ok Oct 11 19:51:40.532 INFO blam! test middleware::session::tests::existing_session ... ok Oct 11 19:51:40.536 INFO blam! test middleware::session::tests::new_session ... ok Oct 11 19:51:40.536 INFO blam! test pipeline::single::tests::test_pipeline_construction ... ok Oct 11 19:51:40.536 INFO blam! test middleware::session::tests::new_session_custom_settings ... ok Oct 11 19:51:40.537 INFO blam! test http::header::x_xss_protection::tests::parse_disable ... ok Oct 11 19:51:40.553 INFO blam! test router::non_match::tests::deconstruct_tests ... ok Oct 11 19:51:40.560 INFO blam! test middleware::session::backend::memory::tests::memory_backend_refresh_test ... ok Oct 11 19:51:40.560 INFO blam! test router::non_match::tests::intersection_tests ... ok Oct 11 19:51:40.561 INFO blam! test router::non_match::tests::union_tests ... ok Oct 11 19:51:40.574 INFO blam! test router::builder::tests::build_router_test ... ok Oct 11 19:51:40.574 INFO blam! test router::route::tests::internal_route_tests ... ok Oct 11 19:51:40.574 INFO blam! test router::route::tests::external_route_tests ... ok Oct 11 19:51:40.574 INFO blam! test router::tests::custom_error_if_leaf_found_but_matching_route_not_found ... ok Oct 11 19:51:40.574 INFO blam! test router::route::dispatch::tests::pipeline_chain_ordering_test ... ok Oct 11 19:51:40.574 INFO blam! test router::builder::draw::tests::delegate_without_pipelines_skips_pipelines ... ok Oct 11 19:51:40.574 INFO blam! test pipeline::tests::pipeline_ordering_test ... ok Oct 11 19:51:40.574 INFO blam! test router::tree::node::tests::manages_children ... ok Oct 11 19:51:40.575 INFO blam! test router::tree::node::tests::node_traversal_tests ... ok Oct 11 19:51:40.575 INFO blam! test router::tests::success_if_leaf_and_route_found ... ok Oct 11 19:51:40.577 INFO blam! test router::tree::node::tests::non_matching_routes_allow_list_tests ... ok Oct 11 19:51:40.577 INFO blam! test router::tests::not_found_error_if_request_path_is_not_found ... ok Oct 11 19:51:40.577 INFO blam! test router::tests::executes_response_finalizer_when_present ... ok Oct 11 19:51:40.577 INFO blam! test router::tests::internal_server_error_if_no_request_path_segments ... ok Oct 11 19:51:40.587 INFO blam! test router::tree::tests::tree_traversal_tests ... ok Oct 11 19:51:40.587 INFO blam! test router::builder::draw::tests::delegate_includes_pipelines ... ok Oct 11 19:51:40.588 INFO blam! test service::tests::new_handler_closure ... ok Oct 11 19:51:40.589 INFO blam! test router::tests::delegates_to_secondary_router ... ok Oct 11 19:51:40.591 INFO blam! test router::tree::node::tests::traverses_children ... ok Oct 11 19:51:40.591 INFO blam! test service::tests::router ... ok Oct 11 19:51:40.603 INFO blam! test service::trap::tests::error ... ok Oct 11 19:51:40.603 INFO blam! test service::trap::tests::async_success_repeat_poll ... ok Oct 11 19:51:40.604 INFO blam! test state::request_id::tests::does_not_overwrite_existant_request_id ... ok Oct 11 19:51:40.605 INFO blam! test service::trap::tests::success ... ok Oct 11 19:51:40.622 INFO blam! test state::request_id::tests::sets_a_unique_request_id ... ok Oct 11 19:51:40.624 INFO blam! test state::request_id::tests::uses_an_external_request_id ... ok Oct 11 19:51:40.650 INFO blam! test test::tests::async_echo ... ok Oct 11 19:51:40.660 INFO blam! test test::tests::serves_requests ... ok Oct 11 19:51:40.667 INFO blam! test test::tests::sets_client_addr ... ok Oct 11 19:51:40.681 INFO blam! test router::tree::node::tests::panics_when_node_with_children_is_provided_delegated_route ... ok Oct 11 19:51:40.681 INFO blam! test router::tree::node::tests::panics_when_delegated_node_adds_children ... ok Oct 11 19:51:40.681 INFO blam! test router::tree::node::tests::panics_when_node_with_a_route_adds_another ... ok Oct 11 19:51:40.707 INFO blam! test service::trap::tests::async_panic ... ok Oct 11 19:51:40.707 INFO blam! test service::trap::tests::panic ... ok Oct 11 19:51:40.708 INFO blam! test service::trap::tests::async_panic_repeat_poll ... ok Oct 11 19:51:40.711 INFO blam! test state::request_id::tests::panics_before_request_id_set ... ok Oct 11 19:51:41.672 INFO blam! test test::tests::times_out ... ok Oct 11 19:51:41.672 INFO blam! Oct 11 19:51:41.672 INFO blam! test result: ok. 82 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 19:51:41.672 INFO blam! Oct 11 19:51:41.674 INFO kablam! Doc-tests gotham Oct 11 19:51:58.540 INFO blam! Oct 11 19:51:58.540 INFO blam! running 99 tests Oct 11 19:52:04.932 INFO blam! test src/extractor/internal.rs - extractor::internal::ExtractorError::UnexpectedEnumVariantType (line 43) ... ok Oct 11 19:52:58.552 INFO blam! test <::hyper::header::common::header macros> - http::header::x_runtime_microseconds::XRuntimeMicroseconds (line 41) ... test <::hyper::header::common::header macros> - http::header::x_runtime_microseconds::XRuntimeMicroseconds (line 41) has been running for over 60 seconds Oct 11 19:52:58.552 INFO blam! test <::hyper::header::common::header macros> - http::header::x_request_id::XRequestId (line 43) ... test <::hyper::header::common::header macros> - http::header::x_request_id::XRequestId (line 43) has been running for over 60 seconds Oct 11 19:52:58.552 INFO blam! test src/extractor/path.rs - extractor::path::PathExtractor (line 21) ... test src/extractor/path.rs - extractor::path::PathExtractor (line 21) has been running for over 60 seconds Oct 11 19:52:58.564 INFO blam! test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) ... test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) has been running for over 60 seconds Oct 11 19:52:58.588 INFO blam! test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) ... test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) has been running for over 60 seconds Oct 11 19:52:58.588 INFO blam! test src/handler/mod.rs - handler::Handler (line 113) ... test src/handler/mod.rs - handler::Handler (line 113) has been running for over 60 seconds Oct 11 19:52:58.588 INFO blam! test src/handler/error.rs - handler::error::IntoHandlerError (line 22) ... test src/handler/error.rs - handler::error::IntoHandlerError (line 22) has been running for over 60 seconds Oct 11 19:53:04.936 INFO blam! test src/handler/mod.rs - handler::Handler (line 40) ... test src/handler/mod.rs - handler::Handler (line 40) has been running for over 60 seconds Oct 11 19:53:12.952 INFO blam! test src/handler/mod.rs - handler::Handler (line 40) ... ok Oct 11 19:53:24.853 INFO blam! test src/handler/error.rs - handler::error::IntoHandlerError (line 22) ... ok Oct 11 19:53:28.230 INFO blam! test src/handler/mod.rs - handler::Handler (line 113) ... ok Oct 11 19:53:29.072 INFO blam! test <::hyper::header::common::header macros> - http::header::x_request_id::XRequestId (line 43) ... ok Oct 11 19:53:30.512 INFO blam! test <::hyper::header::common::header macros> - http::header::x_runtime_microseconds::XRuntimeMicroseconds (line 41) ... ok Oct 11 19:53:33.892 INFO blam! test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) ... ok Oct 11 19:53:34.856 INFO blam! test src/extractor/path.rs - extractor::path::PathExtractor (line 21) ... ok Oct 11 19:53:58.148 INFO blam! test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) ... ok Oct 11 19:54:12.952 INFO blam! test src/handler/mod.rs - handler::Handler (line 63) ... test src/handler/mod.rs - handler::Handler (line 63) has been running for over 60 seconds Oct 11 19:54:24.880 INFO blam! test src/handler/mod.rs - handler::Handler (line 85) ... test src/handler/mod.rs - handler::Handler (line 85) has been running for over 60 seconds Oct 11 19:54:28.233 INFO blam! test src/handler/mod.rs - handler::IntoResponse (line 277) ... test src/handler/mod.rs - handler::IntoResponse (line 277) has been running for over 60 seconds Oct 11 19:54:29.082 INFO blam! test src/handler/mod.rs - handler::NewHandler (line 159) ... test src/handler/mod.rs - handler::NewHandler (line 159) has been running for over 60 seconds Oct 11 19:54:30.521 INFO blam! test src/handler/mod.rs - handler::NewHandler (line 193) ... test src/handler/mod.rs - handler::NewHandler (line 193) has been running for over 60 seconds Oct 11 19:54:33.896 INFO blam! test src/http/header/x_content_type_options.rs - http::header::x_content_type_options::XContentTypeOptions (line 25) ... test src/http/header/x_content_type_options.rs - http::header::x_content_type_options::XContentTypeOptions (line 25) has been running for over 60 seconds Oct 11 19:54:34.860 INFO blam! test src/http/header/x_frame_options.rs - http::header::x_frame_options::XFrameOptions (line 41) ... test src/http/header/x_frame_options.rs - http::header::x_frame_options::XFrameOptions (line 41) has been running for over 60 seconds Oct 11 19:54:43.768 INFO blam! test src/handler/mod.rs - handler::Handler (line 63) ... ok Oct 11 19:54:50.440 INFO blam! test src/handler/mod.rs - handler::Handler (line 85) ... ok Oct 11 19:54:57.528 INFO blam! test src/handler/mod.rs - handler::NewHandler (line 159) ... ok Oct 11 19:54:58.156 INFO blam! test src/http/header/x_xss_protection.rs - http::header::x_xss_protection::XXssProtection (line 21) ... test src/http/header/x_xss_protection.rs - http::header::x_xss_protection::XXssProtection (line 21) has been running for over 60 seconds Oct 11 19:54:58.280 INFO blam! test src/handler/mod.rs - handler::NewHandler (line 193) ... ok Oct 11 19:55:04.104 INFO blam! test src/handler/mod.rs - handler::IntoResponse (line 277) ... ok Oct 11 19:55:07.000 INFO blam! test src/http/header/x_frame_options.rs - http::header::x_frame_options::XFrameOptions (line 41) ... ok Oct 11 19:55:20.184 INFO blam! test src/http/header/x_content_type_options.rs - http::header::x_content_type_options::XContentTypeOptions (line 25) ... ok Oct 11 19:55:43.788 INFO blam! test src/http/response/mod.rs - http::response::create_response (line 20) ... test src/http/response/mod.rs - http::response::create_response (line 20) has been running for over 60 seconds Oct 11 19:55:47.576 INFO blam! test src/http/header/x_xss_protection.rs - http::header::x_xss_protection::XXssProtection (line 21) ... ok Oct 11 19:55:50.428 INFO blam! test src/http/response/mod.rs - http::response::extend_response (line 80) ... test src/http/response/mod.rs - http::response::extend_response (line 80) has been running for over 60 seconds Oct 11 19:55:57.524 INFO blam! test src/http/response/mod.rs - http::response::set_headers (line 166) ... test src/http/response/mod.rs - http::response::set_headers (line 166) has been running for over 60 seconds Oct 11 19:55:58.280 INFO blam! test src/http/response/mod.rs - http::response::set_headers (line 228) ... test src/http/response/mod.rs - http::response::set_headers (line 228) has been running for over 60 seconds Oct 11 19:56:04.116 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 136) ... test src/middleware/mod.rs - middleware::Middleware (line 136) has been running for over 60 seconds Oct 11 19:56:07.020 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 210) ... test src/middleware/mod.rs - middleware::Middleware (line 210) has been running for over 60 seconds Oct 11 19:56:20.176 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 26) ... test src/middleware/mod.rs - middleware::Middleware (line 26) has been running for over 60 seconds Oct 11 19:56:38.496 INFO blam! test src/http/response/mod.rs - http::response::create_response (line 20) ... ok Oct 11 19:56:47.592 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 271) ... test src/middleware/mod.rs - middleware::Middleware (line 271) has been running for over 60 seconds Oct 11 19:56:52.028 INFO blam! test src/http/response/mod.rs - http::response::extend_response (line 80) ... ok Oct 11 19:56:59.364 INFO blam! test src/http/response/mod.rs - http::response::set_headers (line 166) ... ok Oct 11 19:57:04.703 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 210) ... ok Oct 11 19:57:07.972 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 136) ... ok Oct 11 19:57:09.909 INFO blam! test src/http/response/mod.rs - http::response::set_headers (line 228) ... ok Oct 11 19:57:18.058 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 26) ... ok Oct 11 19:57:38.496 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 75) ... test src/middleware/mod.rs - middleware::Middleware (line 75) has been running for over 60 seconds Oct 11 19:57:52.036 INFO blam! test src/middleware/mod.rs - middleware::NewMiddleware (line 343) ... test src/middleware/mod.rs - middleware::NewMiddleware (line 343) has been running for over 60 seconds Oct 11 19:57:57.972 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 271) ... ok Oct 11 19:57:59.368 INFO blam! test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) ... test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) has been running for over 60 seconds Oct 11 19:58:04.708 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 416) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 416) has been running for over 60 seconds Oct 11 19:58:07.975 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 427) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 427) has been running for over 60 seconds Oct 11 19:58:09.916 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 438) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 438) has been running for over 60 seconds Oct 11 19:58:18.065 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::allow_cross_site_usage (line 698) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::allow_cross_site_usage (line 698) has been running for over 60 seconds Oct 11 19:58:53.060 INFO blam! test src/middleware/mod.rs - middleware::Middleware (line 75) ... ok Oct 11 19:58:57.984 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::insecure (line 587) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::insecure (line 587) has been running for over 60 seconds Oct 11 19:58:59.481 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 416) ... ok Oct 11 19:59:01.724 INFO blam! test src/middleware/mod.rs - middleware::NewMiddleware (line 343) ... ok Oct 11 19:59:03.880 INFO blam! test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) ... ok Oct 11 19:59:13.380 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 438) ... ok Oct 11 19:59:16.788 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 427) ... ok Oct 11 19:59:27.475 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::allow_cross_site_usage (line 698) ... ok Oct 11 19:59:53.068 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_domain (line 660) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_domain (line 660) has been running for over 60 seconds Oct 11 19:59:59.040 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::insecure (line 587) ... ok Oct 11 19:59:59.480 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_name (line 629) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_name (line 629) has been running for over 60 seconds Oct 11 20:00:01.720 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_path (line 555) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_path (line 555) has been running for over 60 seconds Oct 11 20:00:03.885 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_session_type (line 763) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_session_type (line 763) has been running for over 60 seconds Oct 11 20:00:13.385 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_strict_same_site_enforcement (line 734) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_strict_same_site_enforcement (line 734) has been running for over 60 seconds Oct 11 20:00:16.804 INFO blam! test src/middleware/session/mod.rs - middleware::session::SessionData (line 186) ... test src/middleware/session/mod.rs - middleware::session::SessionData (line 186) has been running for over 60 seconds Oct 11 20:00:27.472 INFO blam! test src/pipeline/mod.rs - pipeline::Pipeline (line 23) ... test src/pipeline/mod.rs - pipeline::Pipeline (line 23) has been running for over 60 seconds Oct 11 20:00:44.696 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_domain (line 660) ... ok Oct 11 20:00:51.052 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_name (line 629) ... ok Oct 11 20:00:54.072 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_session_type (line 763) ... ok Oct 11 20:00:59.028 INFO blam! test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 175) ... test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 175) has been running for over 60 seconds Oct 11 20:01:07.024 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_strict_same_site_enforcement (line 734) ... ok Oct 11 20:01:13.192 INFO blam! test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware::with_cookie_path (line 555) ... ok Oct 11 20:01:37.872 INFO blam! test src/middleware/session/mod.rs - middleware::session::SessionData (line 186) ... ok Oct 11 20:01:44.720 INFO blam! test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) ... test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) has been running for over 60 seconds Oct 11 20:01:51.056 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 690) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 690) has been running for over 60 seconds Oct 11 20:01:53.564 INFO blam! test src/pipeline/mod.rs - pipeline::Pipeline (line 23) ... ok Oct 11 20:01:54.076 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 556) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 556) has been running for over 60 seconds Oct 11 20:02:07.028 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 608) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 608) has been running for over 60 seconds Oct 11 20:02:13.185 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 275) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 275) has been running for over 60 seconds Oct 11 20:02:17.348 INFO blam! test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 175) ... ok Oct 11 20:02:37.873 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 87) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 87) has been running for over 60 seconds Oct 11 20:02:53.572 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 43) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 43) has been running for over 60 seconds Oct 11 20:02:57.784 INFO blam! test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) ... ok Oct 11 20:03:17.356 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 124) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 124) has been running for over 60 seconds Oct 11 20:03:24.748 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 556) ... ok Oct 11 20:03:38.648 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 690) ... ok Oct 11 20:03:46.087 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 608) ... ok Oct 11 20:03:52.552 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 275) ... ok Oct 11 20:03:57.788 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 312) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 312) has been running for over 60 seconds Oct 11 20:04:06.326 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 87) ... ok Oct 11 20:04:24.751 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::patch (line 237) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::patch (line 237) has been running for over 60 seconds Oct 11 20:04:28.820 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 43) ... ok Oct 11 20:04:38.656 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::post (line 161) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::post (line 161) has been running for over 60 seconds Oct 11 20:04:46.084 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::put (line 199) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::put (line 199) has been running for over 60 seconds Oct 11 20:04:52.553 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 354) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 354) has been running for over 60 seconds Oct 11 20:04:55.880 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 124) ... ok Oct 11 20:05:06.356 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::scope (line 414) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::scope (line 414) has been running for over 60 seconds Oct 11 20:05:28.786 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 312) ... ok Oct 11 20:05:28.813 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::with_pipeline_chain (line 469) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::with_pipeline_chain (line 469) has been running for over 60 seconds Oct 11 20:05:55.980 INFO blam! test src/router/builder/mod.rs - router::builder::AssociatedRouteBuilder<'a, C, P, PE, QSE>::delete (line 804) ... test src/router/builder/mod.rs - router::builder::AssociatedRouteBuilder<'a, C, P, PE, QSE>::delete (line 804) has been running for over 60 seconds Oct 11 20:06:02.209 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::patch (line 237) ... ok Oct 11 20:06:16.340 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::put (line 199) ... ok Oct 11 20:06:18.208 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::post (line 161) ... ok Oct 11 20:06:18.826 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 354) ... ok Oct 11 20:06:28.816 INFO blam! test src/router/builder/mod.rs - router::builder::AssociatedRouteBuilder<'a, C, P, PE, QSE>::get (line 637) ... test src/router/builder/mod.rs - router::builder::AssociatedRouteBuilder<'a, C, P, PE, QSE>::get (line 637) has been running for over 60 seconds Oct 11 20:06:29.340 INFO blam! test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::scope (line 414) ... ok Oct 11 20:06:39.455 INFO error running command: killing a process failed: ESRCH: No such process Oct 11 20:06:39.455 INFO running `"docker" "rm" "-f" "623458e13a1f332f0012e94754a761fb65885a050f7821324f3f1049afbc7ee2"` Oct 11 20:06:41.368 INFO blam! 623458e13a1f332f0012e94754a761fb65885a050f7821324f3f1049afbc7ee2