Nov 18 17:32:04.561 INFO testing cocaine-0.9.2 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 17:32:04.561 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17:32:04.771 INFO [stdout] 785b5a48c597694ff6ccc09e0b1c384ef1eb399f8c3ecaedbde9e0455e96a789
Nov 18 17:32:04.773 INFO running `"docker" "start" "-a" "785b5a48c597694ff6ccc09e0b1c384ef1eb399f8c3ecaedbde9e0455e96a789"`
Nov 18 17:32:05.344 INFO [stderr] usermod: no changes
Nov 18 17:32:05.490 INFO [stderr]    Compiling cocaine v0.9.2 (/source)
Nov 18 17:32:17.503 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.14s
Nov 18 17:32:17.513 INFO [stderr] su: No module specific data is present
Nov 18 17:32:18.600 INFO running `"docker" "inspect" "785b5a48c597694ff6ccc09e0b1c384ef1eb399f8c3ecaedbde9e0455e96a789"`
Nov 18 17:32:18.777 INFO running `"docker" "rm" "-f" "785b5a48c597694ff6ccc09e0b1c384ef1eb399f8c3ecaedbde9e0455e96a789"`
Nov 18 17:32:19.043 INFO [stdout] 785b5a48c597694ff6ccc09e0b1c384ef1eb399f8c3ecaedbde9e0455e96a789
Nov 18 17:32:19.048 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17:32:19.583 INFO [stdout] 68199c25bf7ef132ca420766ad5ddd3d8f535621c3eeb77c40aa8d5a33d32530
Nov 18 17:32:19.585 INFO running `"docker" "start" "-a" "68199c25bf7ef132ca420766ad5ddd3d8f535621c3eeb77c40aa8d5a33d32530"`
Nov 18 17:32:20.668 INFO [stderr] usermod: no changes
Nov 18 17:32:20.927 INFO [stderr]    Compiling slog-extra v0.1.2
Nov 18 17:32:22.957 INFO [stderr]    Compiling slog-stream v1.2.1
Nov 18 17:32:23.776 INFO [stderr]    Compiling slog-term v1.5.0
Nov 18 17:32:27.531 INFO [stderr]    Compiling slog-stdlog v1.1.0
Nov 18 17:32:29.951 INFO [stderr]    Compiling slog-envlogger v0.5.0
Nov 18 17:32:32.991 INFO [stderr]    Compiling cocaine v0.9.2 (/source)
Nov 18 17:33:16.207 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 55.50s
Nov 18 17:33:16.226 INFO [stderr] su: No module specific data is present
Nov 18 17:33:17.070 INFO running `"docker" "inspect" "68199c25bf7ef132ca420766ad5ddd3d8f535621c3eeb77c40aa8d5a33d32530"`
Nov 18 17:33:17.391 INFO running `"docker" "rm" "-f" "68199c25bf7ef132ca420766ad5ddd3d8f535621c3eeb77c40aa8d5a33d32530"`
Nov 18 17:33:17.651 INFO [stdout] 68199c25bf7ef132ca420766ad5ddd3d8f535621c3eeb77c40aa8d5a33d32530
Nov 18 17:33:17.659 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17:33:18.029 INFO [stdout] 4e5ad76b226376dca1b98095204b6272abec0ec8160db05b43dddb5c453dcc24
Nov 18 17:33:18.035 INFO running `"docker" "start" "-a" "4e5ad76b226376dca1b98095204b6272abec0ec8160db05b43dddb5c453dcc24"`
Nov 18 17:33:19.222 INFO [stderr] usermod: no changes
Nov 18 17:33:19.453 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.21s
Nov 18 17:33:19.484 INFO [stderr]      Running /target/debug/deps/cocaine-cf3807829646056c
Nov 18 17:33:19.485 INFO [stdout] 
Nov 18 17:33:19.485 INFO [stdout] running 14 tests
Nov 18 17:33:19.485 INFO [stdout] test logging::tests::test_macro_with_attributes ... ok
Nov 18 17:33:19.485 INFO [stdout] test logging::tests::test_macro_with_attribute ... ok
Nov 18 17:33:19.488 INFO [stdout] test logging::tests::test_macro_with_args_and_attributes ... ok
Nov 18 17:33:19.488 INFO [stdout] test logging::tests::test_macro_with_args ... ok
Nov 18 17:33:19.488 INFO [stdout] test logging::tests::test_macro_without_args ... ok
Nov 18 17:33:19.488 INFO [stdout] test resolve::test::fixed_resolver_default_addrs ... ok
Nov 18 17:33:19.492 INFO [stdout] test resolve::test::fixed_resolver_saves_addrs ... ok
Nov 18 17:33:19.499 INFO [stdout] test frame::test::pass ... ok
Nov 18 17:33:19.500 INFO [stdout] test net::connect::tests::test_connection_refused ... ok
Nov 18 17:33:19.500 INFO [stdout] test net::connect::tests::test_connect ... ok
Nov 18 17:33:19.500 INFO [stdout] test net::connect::tests::test_connect_multi ... ok
Nov 18 17:33:19.579 INFO [stdout] test frame::test::fail_invalid_frame_type ... ok
Nov 18 17:33:19.580 INFO [stdout] test frame::test::fail_invalid_chan_type ... ok
Nov 18 17:33:19.580 INFO [stdout] test frame::test::fail_invalid_type_type ... ok
Nov 18 17:33:19.581 INFO [stdout] 
Nov 18 17:33:19.581 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 17:33:19.581 INFO [stdout] 
Nov 18 17:33:19.595 INFO [stdout] 
Nov 18 17:33:19.595 INFO [stderr]      Running /target/debug/deps/service-de3df365dc71adf3
Nov 18 17:33:19.596 INFO [stdout] running 4 tests
Nov 18 17:33:19.596 INFO [stdout] test dispatch_receives_rst ... ok
Nov 18 17:33:19.616 INFO [stdout] test connection_refused_because_invalid_framing ... ok
Nov 18 17:33:19.617 INFO [stdout] test connect ... ok
Nov 18 17:33:19.617 INFO [stdout] test connection_refused ... ok
Nov 18 17:33:19.617 INFO [stdout] 
Nov 18 17:33:19.618 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 17:33:19.618 INFO [stdout] 
Nov 18 17:33:19.618 INFO [stderr]    Doc-tests cocaine
Nov 18 17:33:25.919 INFO [stdout] 
Nov 18 17:33:25.919 INFO [stdout] running 19 tests
Nov 18 17:34:03.155 INFO [stdout] test src/lib.rs -  (line 23) ... ok
Nov 18 17:34:03.395 INFO [stdout] test src/resolve.rs - resolve::Resolver (line 122) ... ok
Nov 18 17:34:03.631 INFO [stdout] test src/lib.rs -  (line 42) ... ok
Nov 18 17:34:04.647 INFO [stdout] test src/logging.rs - cocaine_log (line 354) ... ok
Nov 18 17:34:06.183 INFO [stdout] test src/logging.rs - cocaine_log (line 371) ... ok
Nov 18 17:34:06.343 INFO [stdout] test src/lib.rs - Service::new (line 1301) ... ok
Nov 18 17:34:07.014 INFO [stdout] test src/request.rs - request::Request (line 16) ... ok
Nov 18 17:34:13.256 INFO [stdout] test src/logging.rs - logging::LoggerContext::new (line 178) ... ok
Nov 18 17:34:35.927 INFO [stdout] test src/response.rs - response::Response<'a, 'b>::deserialize (line 71) ... ok
Nov 18 17:34:47.543 INFO [stdout] test src/service/locator.rs - service::locator::Locator::resolve (line 48) ... ok
Nov 18 17:34:50.044 INFO [stdout] test src/service/mod.rs - service::ServiceBuilder<T>::resolver (line 176) ... ok
Nov 18 17:34:50.578 INFO [stdout] test src/service/storage.rs - service::storage::Storage::read (line 31) ... ok
Nov 18 17:34:52.356 INFO [stdout] test src/service/storage.rs - service::storage::Storage::write (line 60) ... ok
Nov 18 17:34:55.505 INFO [stdout] test src/service/mod.rs - service::ServiceBuilder<ResolverBuilder>::locator_addrs (line 124) ... ok
Nov 18 17:34:57.819 INFO [stdout] test src/service/mod.rs - service::ServiceBuilder (line 82) ... ok
Nov 18 17:34:59.161 INFO [stdout] test src/service/unicorn.rs - service::unicorn::Unicorn::create (line 101) ... ok
Nov 18 17:35:02.983 INFO [stdout] test src/service/unicorn.rs - service::unicorn::Unicorn::del (line 176) ... ok
Nov 18 17:35:06.675 INFO [stdout] test src/service/unicorn.rs - service::unicorn::Unicorn::put (line 139) ... ok
Nov 18 17:35:06.941 INFO [stdout] test src/service/unicorn.rs - service::unicorn::Unicorn::get (line 212) ... ok
Nov 18 17:35:06.941 INFO [stdout] 
Nov 18 17:35:06.941 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 17:35:06.941 INFO [stdout] 
Nov 18 17:35:06.973 INFO [stderr] su: No module specific data is present
Nov 18 17:35:07.371 INFO running `"docker" "inspect" "4e5ad76b226376dca1b98095204b6272abec0ec8160db05b43dddb5c453dcc24"`
Nov 18 17:35:07.661 INFO running `"docker" "rm" "-f" "4e5ad76b226376dca1b98095204b6272abec0ec8160db05b43dddb5c453dcc24"`
Nov 18 17:35:07.878 INFO [stdout] 4e5ad76b226376dca1b98095204b6272abec0ec8160db05b43dddb5c453dcc24