Dec 06 23:00:42.939 INFO testing sharp_pencil-0.4.3 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 23:00:42.939 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:00:43.308 INFO [stdout] d18cd2154f0b119d7aea262ec5c2a5e936c163968c6f58e55bcde38b6805addc
Dec 06 23:00:43.314 INFO running `"docker" "start" "-a" "d18cd2154f0b119d7aea262ec5c2a5e936c163968c6f58e55bcde38b6805addc"`
Dec 06 23:00:44.567 INFO [stderr] usermod: no changes
Dec 06 23:00:44.826 INFO [stderr]    Compiling buf-read-ext v0.2.1
Dec 06 23:00:44.828 INFO [stderr]    Compiling textnonce v0.6.4
Dec 06 23:00:44.828 INFO [stderr]    Compiling handlebars v0.25.3
Dec 06 23:00:47.256 INFO [stderr]    Compiling mime_multipart v0.5.1
Dec 06 23:00:52.516 INFO [stderr]    Compiling formdata v0.12.2
Dec 06 23:00:55.908 INFO [stderr]    Compiling sharp_pencil v0.4.3 (/source)
Dec 06 23:01:03.565 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.97s
Dec 06 23:01:03.575 INFO [stderr] su: No module specific data is present
Dec 06 23:01:04.262 INFO running `"docker" "inspect" "d18cd2154f0b119d7aea262ec5c2a5e936c163968c6f58e55bcde38b6805addc"`
Dec 06 23:01:04.622 INFO running `"docker" "rm" "-f" "d18cd2154f0b119d7aea262ec5c2a5e936c163968c6f58e55bcde38b6805addc"`
Dec 06 23:01:04.888 INFO [stdout] d18cd2154f0b119d7aea262ec5c2a5e936c163968c6f58e55bcde38b6805addc
Dec 06 23:01:04.896 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:01:05.437 INFO [stdout] 141ccea7e3b7cb4b4268c4af0cbbed64ae037bd22dc43caf9a98ea9308e19055
Dec 06 23:01:05.439 INFO running `"docker" "start" "-a" "141ccea7e3b7cb4b4268c4af0cbbed64ae037bd22dc43caf9a98ea9308e19055"`
Dec 06 23:01:06.598 INFO [stderr] usermod: no changes
Dec 06 23:01:06.788 INFO [stderr]    Compiling sharp_pencil v0.4.3 (/source)
Dec 06 23:01:25.116 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.48s
Dec 06 23:01:25.125 INFO [stderr] su: No module specific data is present
Dec 06 23:01:25.942 INFO running `"docker" "inspect" "141ccea7e3b7cb4b4268c4af0cbbed64ae037bd22dc43caf9a98ea9308e19055"`
Dec 06 23:01:26.188 INFO running `"docker" "rm" "-f" "141ccea7e3b7cb4b4268c4af0cbbed64ae037bd22dc43caf9a98ea9308e19055"`
Dec 06 23:01:26.480 INFO [stdout] 141ccea7e3b7cb4b4268c4af0cbbed64ae037bd22dc43caf9a98ea9308e19055
Dec 06 23:01:26.483 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:01:27.012 INFO [stdout] 38c3201b4fa3af8bfa455542a6bd04f8e2cf7a25eb2e50f77ed4eccb5f4a83cc
Dec 06 23:01:27.012 INFO running `"docker" "start" "-a" "38c3201b4fa3af8bfa455542a6bd04f8e2cf7a25eb2e50f77ed4eccb5f4a83cc"`
Dec 06 23:01:28.370 INFO [stderr] usermod: no changes
Dec 06 23:01:28.521 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 06 23:01:28.536 INFO [stderr]      Running /target/debug/deps/sharp_pencil-5298c1c9640a0d48
Dec 06 23:01:28.540 INFO [stdout] 
Dec 06 23:01:28.540 INFO [stdout] running 2 tests
Dec 06 23:01:28.545 INFO [stdout] test httputils::test_get_name_by_http_code ... ok
Dec 06 23:01:28.574 INFO [stdout] test routing::test_basic_routing ... ok
Dec 06 23:01:28.574 INFO [stderr]      Running /target/debug/deps/test_basic-52a7dce9570aee34
Dec 06 23:01:28.574 INFO [stdout] 
Dec 06 23:01:28.574 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.574 INFO [stdout] 
Dec 06 23:01:28.574 INFO [stdout] 
Dec 06 23:01:28.574 INFO [stdout] running 1 test
Dec 06 23:01:28.574 INFO [stdout] test foo ... ok
Dec 06 23:01:28.574 INFO [stdout] 
Dec 06 23:01:28.574 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.574 INFO [stdout] 
Dec 06 23:01:28.576 INFO [stderr]      Running /target/debug/deps/test_config-0c3ea24535188220
Dec 06 23:01:28.591 INFO [stdout] 
Dec 06 23:01:28.591 INFO [stdout] running 4 tests
Dec 06 23:01:28.591 INFO [stdout] test test_config_from_envvar ... ok
Dec 06 23:01:28.593 INFO [stdout] test test_config_from_file ... ok
Dec 06 23:01:28.593 INFO [stderr]      Running /target/debug/deps/test_datastructures-ce5d1ba2fe6c5be5
Dec 06 23:01:28.593 INFO [stdout] test test_config_basic_set ... ok
Dec 06 23:01:28.593 INFO [stdout] test test_config_from_object ... ok
Dec 06 23:01:28.593 INFO [stdout] 
Dec 06 23:01:28.593 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.593 INFO [stdout] 
Dec 06 23:01:28.600 INFO [stdout] 
Dec 06 23:01:28.600 INFO [stderr]      Running /target/debug/deps/test_errors-1b7c1a46cab8e66d
Dec 06 23:01:28.600 INFO [stdout] running 1 test
Dec 06 23:01:28.600 INFO [stdout] test test_multi_dict_basic_interface ... ok
Dec 06 23:01:28.600 INFO [stdout] 
Dec 06 23:01:28.600 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.600 INFO [stdout] 
Dec 06 23:01:28.604 INFO [stdout] 
Dec 06 23:01:28.604 INFO [stdout] running 4 tests
Dec 06 23:01:28.604 INFO [stdout] test test_http_error_get_body ... ok
Dec 06 23:01:28.612 INFO [stdout] test test_http_error_name ... ok
Dec 06 23:01:28.612 INFO [stderr]      Running /target/debug/deps/test_helpers-176db2945a0415b1
Dec 06 23:01:28.612 INFO [stdout] test test_http_error_code ... ok
Dec 06 23:01:28.612 INFO [stdout] test test_http_error_to_response ... ok
Dec 06 23:01:28.612 INFO [stdout] 
Dec 06 23:01:28.612 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.612 INFO [stdout] 
Dec 06 23:01:28.624 INFO [stdout] 
Dec 06 23:01:28.624 INFO [stdout] running 4 tests
Dec 06 23:01:28.624 INFO [stdout] test test_escape ... ok
Dec 06 23:01:28.628 INFO [stdout] test test_redirect ... ok
Dec 06 23:01:28.628 INFO [stderr]    Doc-tests sharp_pencil
Dec 06 23:01:28.628 INFO [stdout] test test_safe_join ... ok
Dec 06 23:01:28.628 INFO [stdout] test test_abort ... ok
Dec 06 23:01:28.628 INFO [stdout] 
Dec 06 23:01:28.628 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:01:28.628 INFO [stdout] 
Dec 06 23:01:36.092 INFO [stdout] 
Dec 06 23:01:36.092 INFO [stdout] running 16 tests
Dec 06 23:01:36.092 INFO [stdout] test src/app.rs - app::Pencil::route (line 167) ... ignored
Dec 06 23:01:36.092 INFO [stdout] test src/app.rs - app::Pencil::test_client (line 377) ... ignored
Dec 06 23:01:36.092 INFO [stdout] test src/helpers.rs - helpers::PathBound::open_resource (line 33) ... ignored
Dec 06 23:01:52.771 INFO [stdout] test src/helpers.rs - helpers::PathBound::open_resource (line 42) ... ok
Dec 06 23:01:52.954 INFO [stdout] test src/http_errors.rs - http_errors::HTTPError (line 44) ... ok
Dec 06 23:01:52.954 INFO [stdout] test src/json.rs - json::jsonify (line 13) ... ignored
Dec 06 23:01:53.330 INFO [stdout] test src/app.rs - app::Pencil::usererrorhandler (line 296) ... ok
Dec 06 23:01:53.338 INFO [stdout] test src/templating.rs - templating::FileSystemLoader::new (line 70) ... ignored
Dec 06 23:01:53.338 INFO [stdout] test src/wrappers.rs - wrappers::Response::new (line 391) ... ignored
Dec 06 23:01:55.082 INFO [stdout] test src/config.rs - config::Config (line 12) ... ok
Dec 06 23:01:55.517 INFO [stdout] test src/app.rs - app::Pencil::httperrorhandler (line 272) ... ok
Dec 06 23:01:55.752 INFO [stdout] test src/app.rs - app::Pencil::usererrorhandler (line 329) ... ok
Dec 06 23:01:56.720 INFO [stdout] test src/app.rs - app::Pencil::new (line 103) ... ok
Dec 06 23:01:57.028 INFO [stdout] test src/config.rs - config::Config (line 20) ... ok
Dec 06 23:02:03.799 INFO [stdout] test src/http_errors.rs - http_errors::HTTPError (line 56) ... ok
Dec 06 23:02:04.717 INFO [stdout] test src/lib.rs -  (line 20) ... ok
Dec 06 23:02:04.717 INFO [stdout] 
Dec 06 23:02:04.717 INFO [stdout] test result: ok. 10 passed; 0 failed; 6 ignored; 0 measured; 0 filtered out
Dec 06 23:02:04.717 INFO [stdout] 
Dec 06 23:02:04.738 INFO [stderr] su: No module specific data is present
Dec 06 23:02:05.360 INFO running `"docker" "inspect" "38c3201b4fa3af8bfa455542a6bd04f8e2cf7a25eb2e50f77ed4eccb5f4a83cc"`
Dec 06 23:02:05.724 INFO running `"docker" "rm" "-f" "38c3201b4fa3af8bfa455542a6bd04f8e2cf7a25eb2e50f77ed4eccb5f4a83cc"`
Dec 06 23:02:05.868 INFO [stdout] 38c3201b4fa3af8bfa455542a6bd04f8e2cf7a25eb2e50f77ed4eccb5f4a83cc