Dec 15 22:54:56.937 INFO testing aitch-0.1.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 22:54:56.937 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 22:54:57.471 INFO [stdout] 09e4b5fe96c60c934bb63c57814f9e3ab409249456a68df98338c9e3c215a80d
Dec 15 22:54:57.475 INFO running `"docker" "start" "-a" "09e4b5fe96c60c934bb63c57814f9e3ab409249456a68df98338c9e3c215a80d"`
Dec 15 22:54:59.028 INFO [stderr] usermod: no changes
Dec 15 22:54:59.471 INFO [stderr]    Compiling tiny_http v0.6.0
Dec 15 22:55:06.624 INFO [stderr]    Compiling aitch v0.1.1 (/source)
Dec 15 22:55:16.800 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.75s
Dec 15 22:55:16.830 INFO [stderr] su: No module specific data is present
Dec 15 22:55:18.175 INFO running `"docker" "inspect" "09e4b5fe96c60c934bb63c57814f9e3ab409249456a68df98338c9e3c215a80d"`
Dec 15 22:55:18.575 INFO running `"docker" "rm" "-f" "09e4b5fe96c60c934bb63c57814f9e3ab409249456a68df98338c9e3c215a80d"`
Dec 15 22:55:18.955 INFO [stdout] 09e4b5fe96c60c934bb63c57814f9e3ab409249456a68df98338c9e3c215a80d
Dec 15 22:55:18.961 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 22:55:19.403 INFO [stdout] 69cd4f52d4462f55d4e4b2749e3d67edb635bbcf9d6a57892047d83e0f296643
Dec 15 22:55:19.405 INFO running `"docker" "start" "-a" "69cd4f52d4462f55d4e4b2749e3d67edb635bbcf9d6a57892047d83e0f296643"`
Dec 15 22:55:21.066 INFO [stderr] usermod: no changes
Dec 15 22:55:21.388 INFO [stderr]    Compiling aitch v0.1.1 (/source)
Dec 15 22:57:27.835 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 06s
Dec 15 22:57:27.850 INFO [stderr] su: No module specific data is present
Dec 15 22:57:28.260 INFO running `"docker" "inspect" "69cd4f52d4462f55d4e4b2749e3d67edb635bbcf9d6a57892047d83e0f296643"`
Dec 15 22:57:28.437 INFO running `"docker" "rm" "-f" "69cd4f52d4462f55d4e4b2749e3d67edb635bbcf9d6a57892047d83e0f296643"`
Dec 15 22:57:28.614 INFO [stdout] 69cd4f52d4462f55d4e4b2749e3d67edb635bbcf9d6a57892047d83e0f296643
Dec 15 22:57:28.617 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 22:57:28.940 INFO [stdout] 754f9b593cdde6cf43703e14d46957f6286dbb1a6627ad0cd77013493c83afc4
Dec 15 22:57:28.943 INFO running `"docker" "start" "-a" "754f9b593cdde6cf43703e14d46957f6286dbb1a6627ad0cd77013493c83afc4"`
Dec 15 22:57:30.381 INFO [stderr] usermod: no changes
Dec 15 22:57:30.699 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.28s
Dec 15 22:57:30.704 INFO [stderr]      Running /target/debug/deps/aitch-20911647ceaffd44
Dec 15 22:57:30.713 INFO [stdout] 
Dec 15 22:57:30.713 INFO [stdout] running 2 tests
Dec 15 22:57:30.713 INFO [stdout] test handlers::static_files::test::match_file_directory_traversal_attack ... ok
Dec 15 22:57:30.714 INFO [stdout] test handlers::static_files::test::match_file_in_directory ... ok
Dec 15 22:57:30.714 INFO [stdout] 
Dec 15 22:57:30.714 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:57:30.714 INFO [stdout] 
Dec 15 22:57:30.715 INFO [stderr]      Running /target/debug/deps/hyper-203b6a507c337254
Dec 15 22:57:30.726 INFO [stdout] 
Dec 15 22:57:30.726 INFO [stdout] running 6 tests
Dec 15 22:57:31.058 INFO [stdout] test json ... ok
Dec 15 22:57:31.084 INFO [stdout] test status_code ... ok
Dec 15 22:57:31.132 INFO [stdout] test echo_server ... ok
Dec 15 22:57:31.175 INFO [stdout] test static_files_handler ... ok
Dec 15 22:57:31.205 INFO [stdout] test static_file_handler ... ok
Dec 15 22:57:31.254 INFO [stdout] test router ... ok
Dec 15 22:57:31.254 INFO [stdout] 
Dec 15 22:57:31.254 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:57:31.254 INFO [stdout] 
Dec 15 22:57:31.262 INFO [stdout] 
Dec 15 22:57:31.262 INFO [stderr]      Running /target/debug/deps/tiny_http-711f0bc00f7afffe
Dec 15 22:57:31.262 INFO [stdout] running 1 test
Dec 15 22:57:31.345 INFO [stdout] test echo_server ... ok
Dec 15 22:57:31.345 INFO [stdout] 
Dec 15 22:57:31.345 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:57:31.345 INFO [stdout] 
Dec 15 22:57:31.348 INFO [stderr]    Doc-tests aitch
Dec 15 22:57:45.303 INFO [stdout] 
Dec 15 22:57:45.303 INFO [stdout] running 20 tests
Dec 15 22:57:45.321 INFO [stdout] test src/handler.rs - handler::Handler (line 13) ... ignored
Dec 15 22:57:45.321 INFO [stdout] test src/lib.rs -  (line 23) ... ignored
Dec 15 22:58:37.280 INFO [stdout] test src/handler.rs - handler::BoxedHandler (line 102) ... ok
Dec 15 22:58:45.303 INFO [stdout] test src/json.rs - json::Json (line 30) ... test src/json.rs - json::Json (line 30) has been running for over 60 seconds
Dec 15 22:58:45.303 INFO [stdout] test src/body.rs - body::Body (line 40) ... test src/body.rs - body::Body (line 40) has been running for over 60 seconds
Dec 15 22:58:45.303 INFO [stdout] test src/handler.rs - handler::Handler (line 24) ... test src/handler.rs - handler::Handler (line 24) has been running for over 60 seconds
Dec 15 22:58:45.303 INFO [stdout] test src/handler.rs - handler::Handler (line 38) ... test src/handler.rs - handler::Handler (line 38) has been running for over 60 seconds
Dec 15 22:58:45.303 INFO [stdout] test src/lib.rs -  (line 124) ... test src/lib.rs -  (line 124) has been running for over 60 seconds
Dec 15 22:58:45.311 INFO [stdout] test src/lib.rs -  (line 137) ... test src/lib.rs -  (line 137) has been running for over 60 seconds
Dec 15 22:58:45.319 INFO [stdout] test src/lib.rs -  (line 35) ... test src/lib.rs -  (line 35) has been running for over 60 seconds
Dec 15 22:58:46.131 INFO [stdout] test src/handler.rs - handler::Handler (line 24) ... ok
Dec 15 22:58:48.503 INFO [stdout] test src/handler.rs - handler::Handler (line 38) ... ok
Dec 15 22:58:49.491 INFO [stdout] test src/json.rs - json::Json (line 30) ... ok
Dec 15 22:58:49.491 INFO [stdout] test src/middlewares/mod.rs - middlewares::with_context (line 92) ... ignored
Dec 15 22:58:51.492 INFO [stdout] test src/body.rs - body::Body (line 40) ... ok
Dec 15 22:58:51.492 INFO [stdout] test src/middlewares/mod.rs - middlewares::with_stdout_logging (line 50) ... ignored
Dec 15 22:58:51.523 INFO [stdout] test src/lib.rs -  (line 124) ... ok
Dec 15 22:58:51.523 INFO [stdout] test src/responder.rs - responder::Responder (line 14) ... ignored
Dec 15 22:58:53.760 INFO [stdout] test src/lib.rs -  (line 137) ... ok
Dec 15 22:58:53.996 INFO [stdout] test src/lib.rs -  (line 35) ... ok
Dec 15 22:59:37.275 INFO [stdout] test src/lib.rs -  (line 79) ... test src/lib.rs -  (line 79) has been running for over 60 seconds
Dec 15 22:59:37.659 INFO [stdout] test src/lib.rs -  (line 79) ... ok
Dec 15 22:59:39.404 INFO [stdout] test src/servers/hyper.rs - servers::hyper::Server (line 54) ... ok
Dec 15 22:59:43.416 INFO [stdout] test src/lib.rs - ResponseBuilder (line 204) ... ok
Dec 15 22:59:43.459 INFO [stdout] test src/middlewares/router.rs - middlewares::router::SimpleRouter (line 28) ... ok
Dec 15 22:59:43.687 INFO [stdout] test src/middlewares/mod.rs - middlewares::with_stdout_logging (line 27) ... ok
Dec 15 22:59:44.142 INFO [stdout] test src/servers/tiny_http/mod.rs - servers::tiny_http::Server (line 53) ... ok
Dec 15 22:59:44.723 INFO [stdout] test src/middlewares/mod.rs - middlewares::with_context (line 107) ... ok
Dec 15 22:59:44.723 INFO [stdout] 
Dec 15 22:59:44.723 INFO [stdout] test result: ok. 15 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out
Dec 15 22:59:44.723 INFO [stdout] 
Dec 15 22:59:44.755 INFO [stderr] su: No module specific data is present
Dec 15 22:59:48.589 INFO running `"docker" "inspect" "754f9b593cdde6cf43703e14d46957f6286dbb1a6627ad0cd77013493c83afc4"`
Dec 15 22:59:48.699 INFO running `"docker" "rm" "-f" "754f9b593cdde6cf43703e14d46957f6286dbb1a6627ad0cd77013493c83afc4"`
Dec 15 22:59:51.317 INFO [stdout] 754f9b593cdde6cf43703e14d46957f6286dbb1a6627ad0cd77013493c83afc4