Nov 18 09:19:32.018 INFO testing hyper-fs-0.2.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 09:19:32.020 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:19:32.500 INFO [stdout] 86d9a99791f4fd06ae9aa8607500ec640dc38c00635d389ef34da8a2a5151dcf
Nov 18 09:19:32.502 INFO running `"docker" "start" "-a" "86d9a99791f4fd06ae9aa8607500ec640dc38c00635d389ef34da8a2a5151dcf"`
Nov 18 09:19:33.859 INFO [stderr] usermod: no changes
Nov 18 09:19:34.139 INFO [stderr]    Compiling hyper-fs v0.2.0 (/source)
Nov 18 09:19:40.987 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.08s
Nov 18 09:19:41.003 INFO [stderr] su: No module specific data is present
Nov 18 09:19:41.942 INFO running `"docker" "inspect" "86d9a99791f4fd06ae9aa8607500ec640dc38c00635d389ef34da8a2a5151dcf"`
Nov 18 09:19:42.357 INFO running `"docker" "rm" "-f" "86d9a99791f4fd06ae9aa8607500ec640dc38c00635d389ef34da8a2a5151dcf"`
Nov 18 09:19:42.670 INFO [stdout] 86d9a99791f4fd06ae9aa8607500ec640dc38c00635d389ef34da8a2a5151dcf
Nov 18 09:19:42.676 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:19:43.122 INFO [stdout] 2fd7d7646bb6cf2e498521d1d54ce0aa208ce66a6cea55d03bad480281708916
Nov 18 09:19:43.124 INFO running `"docker" "start" "-a" "2fd7d7646bb6cf2e498521d1d54ce0aa208ce66a6cea55d03bad480281708916"`
Nov 18 09:19:44.215 INFO [stderr] usermod: no changes
Nov 18 09:19:44.583 INFO [stderr]    Compiling mxo_env_logger v0.1.0
Nov 18 09:19:46.192 INFO [stderr]    Compiling hyper-fs v0.2.0 (/source)
Nov 18 09:20:05.079 INFO [stderr] warning: use of deprecated item 'hyper::server::server_proto::<impl hyper::server::Http<B>>::bind_connection': All usage of the tokio-proto crate is going away.
Nov 18 09:20:05.079 INFO [stderr]   --> examples/hyper-index.rs:51:14
Nov 18 09:20:05.079 INFO [stderr]    |
Nov 18 09:20:05.079 INFO [stderr] 51 |         http.bind_connection(&handle, socket, addr, index_server.clone());
Nov 18 09:20:05.079 INFO [stderr]    |              ^^^^^^^^^^^^^^^
Nov 18 09:20:05.079 INFO [stderr]    |
Nov 18 09:20:05.081 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 09:20:05.081 INFO [stderr] 
Nov 18 09:20:06.627 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 09:20:06.627 INFO [stderr]  --> examples/hyper-file.rs:4:1
Nov 18 09:20:06.627 INFO [stderr]   |
Nov 18 09:20:06.627 INFO [stderr] 4 | #[macro_use]
Nov 18 09:20:06.627 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 09:20:06.627 INFO [stderr]   |
Nov 18 09:20:06.627 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 09:20:06.627 INFO [stderr] 
Nov 18 09:20:06.803 INFO [stderr] warning: use of deprecated item 'hyper::server::server_proto::<impl hyper::server::Http<B>>::bind_connection': All usage of the tokio-proto crate is going away.
Nov 18 09:20:06.803 INFO [stderr]   --> examples/hyper-file.rs:49:14
Nov 18 09:20:06.803 INFO [stderr]    |
Nov 18 09:20:06.803 INFO [stderr] 49 |         http.bind_connection(&handle, socket, addr, file_server.clone());
Nov 18 09:20:06.803 INFO [stderr]    |              ^^^^^^^^^^^^^^^
Nov 18 09:20:06.804 INFO [stderr]    |
Nov 18 09:20:06.804 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 09:20:06.804 INFO [stderr] 
Nov 18 09:20:07.483 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 09:20:07.483 INFO [stderr]  --> examples/hyper-fs.rs:4:1
Nov 18 09:20:07.483 INFO [stderr]   |
Nov 18 09:20:07.483 INFO [stderr] 4 | #[macro_use]
Nov 18 09:20:07.483 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 09:20:07.483 INFO [stderr]   |
Nov 18 09:20:07.483 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 09:20:07.483 INFO [stderr] 
Nov 18 09:20:07.767 INFO [stderr] warning: use of deprecated item 'hyper::server::server_proto::<impl hyper::server::Http<B>>::bind_connection': All usage of the tokio-proto crate is going away.
Nov 18 09:20:07.767 INFO [stderr]   --> examples/hyper-fs.rs:53:14
Nov 18 09:20:07.767 INFO [stderr]    |
Nov 18 09:20:07.767 INFO [stderr] 53 |         http.bind_connection(&handle, socket, addr, fs_server.clone());
Nov 18 09:20:07.767 INFO [stderr]    |              ^^^^^^^^^^^^^^^
Nov 18 09:20:07.767 INFO [stderr]    |
Nov 18 09:20:07.767 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 09:20:07.767 INFO [stderr] 
Nov 18 09:20:07.839 INFO [stderr] warning: use of deprecated item '<hyper::Request<B>>::remote_addr': This method will be gone in future versions.
Nov 18 09:20:07.839 INFO [stderr]    --> examples/hyper-fs.rs:107:18
Nov 18 09:20:07.839 INFO [stderr]     |
Nov 18 09:20:07.839 INFO [stderr] 107 |                 .remote_addr()
Nov 18 09:20:07.839 INFO [stderr]     |                  ^^^^^^^^^^^
Nov 18 09:20:07.839 INFO [stderr] 
Nov 18 09:20:08.407 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 09:20:08.407 INFO [stderr]  --> examples/hyper-doc.rs:4:1
Nov 18 09:20:08.407 INFO [stderr]   |
Nov 18 09:20:08.407 INFO [stderr] 4 | #[macro_use]
Nov 18 09:20:08.407 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 09:20:08.407 INFO [stderr]   |
Nov 18 09:20:08.407 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 09:20:08.407 INFO [stderr] 
Nov 18 09:20:08.879 INFO [stderr] warning: use of deprecated item 'hyper::server::server_proto::<impl hyper::server::Http<B>>::bind_connection': All usage of the tokio-proto crate is going away.
Nov 18 09:20:08.879 INFO [stderr]   --> examples/hyper-doc.rs:49:14
Nov 18 09:20:08.880 INFO [stderr]    |
Nov 18 09:20:08.880 INFO [stderr] 49 |         http.bind_connection(&handle, socket, addr, doc.clone());
Nov 18 09:20:08.880 INFO [stderr]    |              ^^^^^^^^^^^^^^^
Nov 18 09:20:08.880 INFO [stderr]    |
Nov 18 09:20:08.880 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 09:20:08.880 INFO [stderr] 
Nov 18 09:20:16.071 INFO [stderr] warning: use of deprecated item 'hyper::server::server_proto::<impl hyper::server::Http<B>>::bind_connection': All usage of the tokio-proto crate is going away.
Nov 18 09:20:16.071 INFO [stderr]    --> tests/test_fs.rs:194:14
Nov 18 09:20:16.071 INFO [stderr]     |
Nov 18 09:20:16.071 INFO [stderr] 194 |         http.bind_connection(&handle, socket, addr, fs_server.clone());
Nov 18 09:20:16.071 INFO [stderr]     |              ^^^^^^^^^^^^^^^
Nov 18 09:20:16.071 INFO [stderr]     |
Nov 18 09:20:16.071 INFO [stderr]     = note: #[warn(deprecated)] on by default
Nov 18 09:20:16.071 INFO [stderr] 
Nov 18 09:20:30.649 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 46.40s
Nov 18 09:20:30.663 INFO [stderr] su: No module specific data is present
Nov 18 09:20:31.097 INFO running `"docker" "inspect" "2fd7d7646bb6cf2e498521d1d54ce0aa208ce66a6cea55d03bad480281708916"`
Nov 18 09:20:31.199 INFO running `"docker" "rm" "-f" "2fd7d7646bb6cf2e498521d1d54ce0aa208ce66a6cea55d03bad480281708916"`
Nov 18 09:20:31.300 INFO [stdout] 2fd7d7646bb6cf2e498521d1d54ce0aa208ce66a6cea55d03bad480281708916
Nov 18 09:20:31.300 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:20:31.507 INFO [stdout] 5603f39d7bf72a1740f2c8de12960ad5f61f07cd16e03bc68fce7bd8ad1df9e7
Nov 18 09:20:31.509 INFO running `"docker" "start" "-a" "5603f39d7bf72a1740f2c8de12960ad5f61f07cd16e03bc68fce7bd8ad1df9e7"`
Nov 18 09:20:31.960 INFO [stderr] usermod: no changes
Nov 18 09:20:32.149 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 18 09:20:32.174 INFO [stderr]      Running /target/debug/deps/hyper_fs-23986f5bdca42ab4
Nov 18 09:20:32.177 INFO [stdout] 
Nov 18 09:20:32.177 INFO [stdout] running 1 test
Nov 18 09:20:32.177 INFO [stdout] test static_fs::router_test ... ok
Nov 18 09:20:32.177 INFO [stdout] 
Nov 18 09:20:32.177 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:20:32.177 INFO [stdout] 
Nov 18 09:20:32.178 INFO [stderr]      Running /target/debug/deps/test_fs-df68975383beb111
Nov 18 09:20:32.182 INFO [stdout] 
Nov 18 09:20:32.182 INFO [stdout] running 1 test
Nov 18 09:20:32.184 INFO [stderr] INFO #test_fs:197: Listening on http://0.0.0.0:38947 with 1 thread.
Nov 18 09:20:32.200 INFO [stderr] INFO #test_fs:251: 0ms 200 GET //
Nov 18 09:20:32.201 INFO [stderr] INFO #test_fs:129: test_dir_(./ -> http://0.0.0.0:38947/%2E//) -> true
Nov 18 09:20:32.206 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /Cargo.lock
Nov 18 09:20:32.207 INFO [stderr] INFO #test_fs:84: test_file(Cargo.lock -> http://0.0.0.0:38947/%43%61%72%67%6F%2E%6C%6F%63%6B) -> true
Nov 18 09:20:32.249 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /Cargo.toml.orig
Nov 18 09:20:32.250 INFO [stderr] INFO #test_fs:84: test_file(Cargo.toml.orig -> http://0.0.0.0:38947/%43%61%72%67%6F%2E%74%6F%6D%6C%2E%6F%72%69%67) -> true
Nov 18 09:20:32.297 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/
Nov 18 09:20:32.297 INFO [stderr] INFO #test_fs:129: test_dir_(src -> http://0.0.0.0:38947/%73%72%63/) -> true
Nov 18 09:20:32.299 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/static_file.rs
Nov 18 09:20:32.299 INFO [stderr] INFO #test_fs:84: test_file(src/static_file.rs -> http://0.0.0.0:38947/%73%72%63/%73%74%61%74%69%63%5F%66%69%6C%65%2E%72%73) -> true
Nov 18 09:20:32.345 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/static_fs.rs
Nov 18 09:20:32.345 INFO [stderr] INFO #test_fs:84: test_file(src/static_fs.rs -> http://0.0.0.0:38947/%73%72%63/%73%74%61%74%69%63%5F%66%73%2E%72%73) -> true
Nov 18 09:20:32.389 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/lib.rs
Nov 18 09:20:32.390 INFO [stderr] INFO #test_fs:84: test_file(src/lib.rs -> http://0.0.0.0:38947/%73%72%63/%6C%69%62%2E%72%73) -> true
Nov 18 09:20:32.433 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/config.rs
Nov 18 09:20:32.434 INFO [stderr] INFO #test_fs:84: test_file(src/config.rs -> http://0.0.0.0:38947/%73%72%63/%63%6F%6E%66%69%67%2E%72%73) -> true
Nov 18 09:20:32.478 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/error.rs
Nov 18 09:20:32.478 INFO [stderr] INFO #test_fs:84: test_file(src/error.rs -> http://0.0.0.0:38947/%73%72%63/%65%72%72%6F%72%2E%72%73) -> true
Nov 18 09:20:32.525 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/content_type.rs
Nov 18 09:20:32.525 INFO [stderr] INFO #test_fs:84: test_file(src/content_type.rs -> http://0.0.0.0:38947/%73%72%63/%63%6F%6E%74%65%6E%74%5F%74%79%70%65%2E%72%73) -> true
Nov 18 09:20:32.570 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /src/static_index.rs
Nov 18 09:20:32.570 INFO [stderr] INFO #test_fs:84: test_file(src/static_index.rs -> http://0.0.0.0:38947/%73%72%63/%73%74%61%74%69%63%5F%69%6E%64%65%78%2E%72%73) -> true
Nov 18 09:20:32.613 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /Cargo.toml
Nov 18 09:20:32.614 INFO [stderr] INFO #test_fs:84: test_file(Cargo.toml -> http://0.0.0.0:38947/%43%61%72%67%6F%2E%74%6F%6D%6C) -> true
Nov 18 09:20:32.657 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /LICENSE
Nov 18 09:20:32.657 INFO [stderr] INFO #test_fs:84: test_file(LICENSE -> http://0.0.0.0:38947/%4C%49%43%45%4E%53%45) -> true
Nov 18 09:20:32.707 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /readme.md
Nov 18 09:20:32.707 INFO [stderr] INFO #test_fs:84: test_file(readme.md -> http://0.0.0.0:38947/%72%65%61%64%6D%65%2E%6D%64) -> true
Nov 18 09:20:32.753 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /examples/
Nov 18 09:20:32.753 INFO [stderr] INFO #test_fs:129: test_dir_(examples -> http://0.0.0.0:38947/%65%78%61%6D%70%6C%65%73/) -> true
Nov 18 09:20:32.755 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /examples/hyper-index.rs
Nov 18 09:20:32.756 INFO [stderr] INFO #test_fs:84: test_file(examples/hyper-index.rs -> http://0.0.0.0:38947/%65%78%61%6D%70%6C%65%73/%68%79%70%65%72%2D%69%6E%64%65%78%2E%72%73) -> true
Nov 18 09:20:32.803 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /examples/hyper-doc.rs
Nov 18 09:20:32.803 INFO [stderr] INFO #test_fs:84: test_file(examples/hyper-doc.rs -> http://0.0.0.0:38947/%65%78%61%6D%70%6C%65%73/%68%79%70%65%72%2D%64%6F%63%2E%72%73) -> true
Nov 18 09:20:32.849 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /examples/hyper-file.rs
Nov 18 09:20:32.850 INFO [stderr] INFO #test_fs:84: test_file(examples/hyper-file.rs -> http://0.0.0.0:38947/%65%78%61%6D%70%6C%65%73/%68%79%70%65%72%2D%66%69%6C%65%2E%72%73) -> true
Nov 18 09:20:32.893 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /examples/hyper-fs.rs
Nov 18 09:20:32.894 INFO [stderr] INFO #test_fs:84: test_file(examples/hyper-fs.rs -> http://0.0.0.0:38947/%65%78%61%6D%70%6C%65%73/%68%79%70%65%72%2D%66%73%2E%72%73) -> true
Nov 18 09:20:32.937 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /tests/
Nov 18 09:20:32.937 INFO [stderr] INFO #test_fs:129: test_dir_(tests -> http://0.0.0.0:38947/%74%65%73%74%73/) -> true
Nov 18 09:20:32.939 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /tests/index/
Nov 18 09:20:32.940 INFO [stderr] INFO #test_fs:129: test_dir_(tests/index -> http://0.0.0.0:38947/%74%65%73%74%73/%69%6E%64%65%78/) -> true
Nov 18 09:20:32.942 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /tests/index/file
Nov 18 09:20:32.942 INFO [stderr] INFO #test_fs:84: test_file(tests/index/file -> http://0.0.0.0:38947/%74%65%73%74%73/%69%6E%64%65%78/%66%69%6C%65) -> true
Nov 18 09:20:32.944 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /tests/test_fs.rs
Nov 18 09:20:32.944 INFO [stderr] INFO #test_fs:84: test_file(tests/test_fs.rs -> http://0.0.0.0:38947/%74%65%73%74%73/%74%65%73%74%5F%66%73%2E%72%73) -> true
Nov 18 09:20:32.993 INFO [stderr] INFO #test_fs:251: 0ms 200 GET /rustfmt.toml
Nov 18 09:20:32.993 INFO [stderr] INFO #test_fs:84: test_file(rustfmt.toml -> http://0.0.0.0:38947/%72%75%73%74%66%6D%74%2E%74%6F%6D%6C) -> true
Nov 18 09:20:33.038 INFO [stdout] test main ... ok
Nov 18 09:20:33.038 INFO [stdout] 
Nov 18 09:20:33.038 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:20:33.038 INFO [stdout] 
Nov 18 09:20:33.039 INFO [stderr]    Doc-tests hyper-fs
Nov 18 09:20:41.103 INFO [stdout] 
Nov 18 09:20:41.103 INFO [stdout] running 0 tests
Nov 18 09:20:41.103 INFO [stdout] 
Nov 18 09:20:41.103 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:20:41.103 INFO [stdout] 
Nov 18 09:20:41.115 INFO [stderr] su: No module specific data is present
Nov 18 09:20:41.420 INFO running `"docker" "inspect" "5603f39d7bf72a1740f2c8de12960ad5f61f07cd16e03bc68fce7bd8ad1df9e7"`
Nov 18 09:20:41.536 INFO running `"docker" "rm" "-f" "5603f39d7bf72a1740f2c8de12960ad5f61f07cd16e03bc68fce7bd8ad1df9e7"`
Nov 18 09:20:41.663 INFO [stdout] 5603f39d7bf72a1740f2c8de12960ad5f61f07cd16e03bc68fce7bd8ad1df9e7