Nov 16 12:47:01.285 INFO testing sourgrasses/opalkv against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 12:47:01.285 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 12:47:01.704 INFO [stdout] 3e51e7759ed7a8b02d8679e0bb4ce49ffa82ec69a262842403c2698be6990d0c
Nov 16 12:47:01.706 INFO running `"docker" "start" "-a" "3e51e7759ed7a8b02d8679e0bb4ce49ffa82ec69a262842403c2698be6990d0c"`
Nov 16 12:47:04.498 INFO [stderr] usermod: no changes
Nov 16 12:47:04.734 INFO [stderr]    Compiling smallvec v0.6.2
Nov 16 12:47:04.734 INFO [stderr]    Compiling crossbeam-utils v0.4.1
Nov 16 12:47:04.749 INFO [stderr]    Compiling zstd-sys v1.4.3+zstd.1.3.4
Nov 16 12:47:04.764 INFO [stderr]    Compiling mio v0.6.14
Nov 16 12:47:04.767 INFO [stderr]    Compiling tokio-io v0.1.7
Nov 16 12:47:04.769 INFO [stderr]    Compiling tokio-threadpool v0.1.4
Nov 16 12:47:08.059 INFO [stderr]    Compiling parking_lot_core v0.2.14
Nov 16 12:47:10.185 INFO [stderr]    Compiling tokio-codec v0.1.0
Nov 16 12:47:11.007 INFO [stderr]    Compiling parking_lot v0.5.5
Nov 16 12:47:13.935 INFO [stderr]    Compiling tokio-reactor v0.1.2
Nov 16 12:47:14.375 INFO [stderr]    Compiling tokio-fs v0.1.1
Nov 16 12:47:14.586 INFO [stderr]    Compiling crossbeam-channel v0.2.1
Nov 16 12:47:16.075 INFO [stderr]    Compiling tokio-tcp v0.1.0
Nov 16 12:47:16.076 INFO [stderr]    Compiling tokio-udp v0.1.1
Nov 16 12:47:18.219 INFO [stderr]    Compiling tokio v0.1.7
Nov 16 12:47:21.241 INFO [stderr]    Compiling tokio-core v0.1.17
Nov 16 12:47:25.039 INFO [stderr]    Compiling tokio-tls v0.1.4
Nov 16 12:47:56.115 INFO [stderr]    Compiling zstd-safe v1.4.3+zstd.1.3.4
Nov 16 12:47:56.635 INFO [stderr]    Compiling zstd v0.4.18+zstd.1.3.4
Nov 16 12:47:57.451 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Nov 16 12:47:58.054 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 12:47:58.054 INFO [stderr]  --> src/main.rs:5:1
Nov 16 12:47:58.055 INFO [stderr]   |
Nov 16 12:47:58.055 INFO [stderr] 5 | #[macro_use]
Nov 16 12:47:58.055 INFO [stderr]   | ^^^^^^^^^^^^
Nov 16 12:47:58.055 INFO [stderr]   |
Nov 16 12:47:58.056 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 12:47:58.056 INFO [stderr] 
Nov 16 12:47:58.187 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Nov 16 12:47:58.187 INFO [stderr]   --> src/server.rs:31:40
Nov 16 12:47:58.187 INFO [stderr]    |
Nov 16 12:47:58.187 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Nov 16 12:47:58.187 INFO [stderr]    |                                        ^^^^^^
Nov 16 12:47:58.187 INFO [stderr]    |
Nov 16 12:47:58.187 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 16 12:47:58.187 INFO [stderr] 
Nov 16 12:47:58.195 INFO [stderr] warning: unused variable: `page_size`
Nov 16 12:47:58.195 INFO [stderr]   --> src/main.rs:25:9
Nov 16 12:47:58.195 INFO [stderr]    |
Nov 16 12:47:58.195 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Nov 16 12:47:58.195 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Nov 16 12:47:58.195 INFO [stderr]    |
Nov 16 12:47:58.195 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 12:47:58.195 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: field is never used: `map`
Nov 16 12:47:58.231 INFO [stderr]   --> src/hash/mod.rs:10:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: method is never used: `get`
Nov 16 12:47:58.231 INFO [stderr]   --> src/hash/mod.rs:20:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: method is never used: `put`
Nov 16 12:47:58.231 INFO [stderr]   --> src/hash/mod.rs:24:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: method is never used: `del`
Nov 16 12:47:58.231 INFO [stderr]   --> src/hash/mod.rs:28:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: method is never used: `query`
Nov 16 12:47:58.231 INFO [stderr]   --> src/hash/mod.rs:32:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: method is never used: `new`
Nov 16 12:47:58.231 INFO [stderr]   --> src/query.rs:22:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: field is never used: `db`
Nov 16 12:47:58.231 INFO [stderr]   --> src/server.rs:12:5
Nov 16 12:47:58.231 INFO [stderr]    |
Nov 16 12:47:58.231 INFO [stderr] 12 |     db: OpalDb,
Nov 16 12:47:58.231 INFO [stderr]    |     ^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:58.231 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Nov 16 12:47:58.231 INFO [stderr]  --> src/main.rs:1:12
Nov 16 12:47:58.231 INFO [stderr]   |
Nov 16 12:47:58.231 INFO [stderr] 1 | #![feature(extern_prelude)]
Nov 16 12:47:58.231 INFO [stderr]   |            ^^^^^^^^^^^^^^
Nov 16 12:47:58.231 INFO [stderr]   |
Nov 16 12:47:58.231 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 16 12:47:58.231 INFO [stderr] 
Nov 16 12:47:59.946 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 55.42s
Nov 16 12:47:59.956 INFO [stderr] su: No module specific data is present
Nov 16 12:48:00.413 INFO running `"docker" "inspect" "3e51e7759ed7a8b02d8679e0bb4ce49ffa82ec69a262842403c2698be6990d0c"`
Nov 16 12:48:00.591 INFO running `"docker" "rm" "-f" "3e51e7759ed7a8b02d8679e0bb4ce49ffa82ec69a262842403c2698be6990d0c"`
Nov 16 12:48:00.798 INFO [stdout] 3e51e7759ed7a8b02d8679e0bb4ce49ffa82ec69a262842403c2698be6990d0c
Nov 16 12:48:00.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 12:48:01.140 INFO [stdout] fcd52c9c14542cd0e3c457467b1945c2b27dbc533b839c5eccc53baf88d1bdec
Nov 16 12:48:01.142 INFO running `"docker" "start" "-a" "fcd52c9c14542cd0e3c457467b1945c2b27dbc533b839c5eccc53baf88d1bdec"`
Nov 16 12:48:01.722 INFO [stderr] usermod: no changes
Nov 16 12:48:01.901 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Nov 16 12:48:02.607 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 12:48:02.611 INFO [stderr]  --> src/main.rs:5:1
Nov 16 12:48:02.611 INFO [stderr]   |
Nov 16 12:48:02.611 INFO [stderr] 5 | #[macro_use]
Nov 16 12:48:02.611 INFO [stderr]   | ^^^^^^^^^^^^
Nov 16 12:48:02.611 INFO [stderr]   |
Nov 16 12:48:02.611 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 12:48:02.611 INFO [stderr] 
Nov 16 12:48:02.747 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Nov 16 12:48:02.747 INFO [stderr]   --> src/server.rs:31:40
Nov 16 12:48:02.747 INFO [stderr]    |
Nov 16 12:48:02.747 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Nov 16 12:48:02.747 INFO [stderr]    |                                        ^^^^^^
Nov 16 12:48:02.747 INFO [stderr]    |
Nov 16 12:48:02.747 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 16 12:48:02.747 INFO [stderr] 
Nov 16 12:48:02.750 INFO [stderr] warning: unused variable: `page_size`
Nov 16 12:48:02.750 INFO [stderr]   --> src/main.rs:25:9
Nov 16 12:48:02.750 INFO [stderr]    |
Nov 16 12:48:02.750 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Nov 16 12:48:02.750 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Nov 16 12:48:02.750 INFO [stderr]    |
Nov 16 12:48:02.750 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 12:48:02.750 INFO [stderr] 
Nov 16 12:48:02.780 INFO [stderr] warning: field is never used: `map`
Nov 16 12:48:02.780 INFO [stderr]   --> src/hash/mod.rs:10:5
Nov 16 12:48:02.780 INFO [stderr]    |
Nov 16 12:48:02.780 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Nov 16 12:48:02.780 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.780 INFO [stderr]    |
Nov 16 12:48:02.780 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 12:48:02.780 INFO [stderr] 
Nov 16 12:48:02.780 INFO [stderr] warning: method is never used: `get`
Nov 16 12:48:02.780 INFO [stderr]   --> src/hash/mod.rs:20:5
Nov 16 12:48:02.780 INFO [stderr]    |
Nov 16 12:48:02.780 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Nov 16 12:48:02.780 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.780 INFO [stderr] 
Nov 16 12:48:02.780 INFO [stderr] warning: method is never used: `put`
Nov 16 12:48:02.780 INFO [stderr]   --> src/hash/mod.rs:24:5
Nov 16 12:48:02.780 INFO [stderr]    |
Nov 16 12:48:02.780 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Nov 16 12:48:02.780 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.780 INFO [stderr] 
Nov 16 12:48:02.780 INFO [stderr] warning: method is never used: `del`
Nov 16 12:48:02.781 INFO [stderr]   --> src/hash/mod.rs:28:5
Nov 16 12:48:02.781 INFO [stderr]    |
Nov 16 12:48:02.781 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Nov 16 12:48:02.781 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.781 INFO [stderr] 
Nov 16 12:48:02.781 INFO [stderr] warning: method is never used: `query`
Nov 16 12:48:02.781 INFO [stderr]   --> src/hash/mod.rs:32:5
Nov 16 12:48:02.781 INFO [stderr]    |
Nov 16 12:48:02.781 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Nov 16 12:48:02.781 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.781 INFO [stderr] 
Nov 16 12:48:02.781 INFO [stderr] warning: method is never used: `new`
Nov 16 12:48:02.781 INFO [stderr]   --> src/query.rs:22:5
Nov 16 12:48:02.781 INFO [stderr]    |
Nov 16 12:48:02.781 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Nov 16 12:48:02.781 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.781 INFO [stderr] 
Nov 16 12:48:02.781 INFO [stderr] warning: field is never used: `db`
Nov 16 12:48:02.781 INFO [stderr]   --> src/server.rs:12:5
Nov 16 12:48:02.781 INFO [stderr]    |
Nov 16 12:48:02.781 INFO [stderr] 12 |     db: OpalDb,
Nov 16 12:48:02.781 INFO [stderr]    |     ^^^^^^^^^^
Nov 16 12:48:02.781 INFO [stderr] 
Nov 16 12:48:02.781 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Nov 16 12:48:02.781 INFO [stderr]  --> src/main.rs:1:12
Nov 16 12:48:02.781 INFO [stderr]   |
Nov 16 12:48:02.781 INFO [stderr] 1 | #![feature(extern_prelude)]
Nov 16 12:48:02.781 INFO [stderr]   |            ^^^^^^^^^^^^^^
Nov 16 12:48:02.781 INFO [stderr]   |
Nov 16 12:48:02.781 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 16 12:48:02.781 INFO [stderr] 
Nov 16 12:48:03.082 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.33s
Nov 16 12:48:03.094 INFO [stderr] su: No module specific data is present
Nov 16 12:48:03.396 INFO running `"docker" "inspect" "fcd52c9c14542cd0e3c457467b1945c2b27dbc533b839c5eccc53baf88d1bdec"`
Nov 16 12:48:03.527 INFO running `"docker" "rm" "-f" "fcd52c9c14542cd0e3c457467b1945c2b27dbc533b839c5eccc53baf88d1bdec"`
Nov 16 12:48:03.610 INFO [stdout] fcd52c9c14542cd0e3c457467b1945c2b27dbc533b839c5eccc53baf88d1bdec
Nov 16 12:48:03.615 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 12:48:03.881 INFO [stdout] b22088aba6e9c9212a4164e6ee94445fed1087f25802e9d498777efd196f4744
Nov 16 12:48:03.883 INFO running `"docker" "start" "-a" "b22088aba6e9c9212a4164e6ee94445fed1087f25802e9d498777efd196f4744"`
Nov 16 12:48:04.269 INFO [stderr] usermod: no changes
Nov 16 12:48:04.380 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Nov 16 12:48:04.384 INFO [stderr]      Running /target/debug/deps/opalkv-8ef1902576d84dfa
Nov 16 12:48:04.393 INFO [stdout] 
Nov 16 12:48:04.393 INFO [stdout] running 0 tests
Nov 16 12:48:04.393 INFO [stdout] 
Nov 16 12:48:04.393 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 12:48:04.393 INFO [stdout] 
Nov 16 12:48:04.395 INFO [stderr] su: No module specific data is present
Nov 16 12:48:04.712 INFO running `"docker" "inspect" "b22088aba6e9c9212a4164e6ee94445fed1087f25802e9d498777efd196f4744"`
Nov 16 12:48:04.812 INFO running `"docker" "rm" "-f" "b22088aba6e9c9212a4164e6ee94445fed1087f25802e9d498777efd196f4744"`
Nov 16 12:48:04.891 INFO [stdout] b22088aba6e9c9212a4164e6ee94445fed1087f25802e9d498777efd196f4744