Nov 16 12:46:53.866 INFO testing sourgrasses/opalkv against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 12:46:53.867 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 16 12:46:54.242 INFO [stdout] 8d722231e17bd2f05dada60cab8ac9dd955a1b735b5e9d685e03b8cb715c214c
Nov 16 12:46:54.244 INFO running `"docker" "start" "-a" "8d722231e17bd2f05dada60cab8ac9dd955a1b735b5e9d685e03b8cb715c214c"`
Nov 16 12:46:56.019 INFO [stderr] usermod: no changes
Nov 16 12:46:56.300 INFO [stderr]    Compiling smallvec v0.6.2
Nov 16 12:46:56.301 INFO [stderr]    Compiling crossbeam-utils v0.4.1
Nov 16 12:46:56.301 INFO [stderr]    Compiling log v0.4.2
Nov 16 12:46:56.315 INFO [stderr]    Compiling zstd-sys v1.4.3+zstd.1.3.4
Nov 16 12:46:56.316 INFO [stderr]    Compiling crossbeam-epoch v0.4.3
Nov 16 12:46:56.399 INFO [stderr]    Compiling tokio-timer v0.2.4
Nov 16 12:46:56.411 INFO [stderr]    Compiling openssl v0.9.24
Nov 16 12:46:59.271 INFO [stderr]    Compiling tokio-io v0.1.7
Nov 16 12:46:59.271 INFO [stderr]    Compiling mio v0.6.14
Nov 16 12:46:59.399 INFO [stderr]    Compiling parking_lot_core v0.2.14
Nov 16 12:47:02.675 INFO [stderr]    Compiling crossbeam-deque v0.3.1
Nov 16 12:47:05.824 INFO [stderr]    Compiling parking_lot v0.5.5
Nov 16 12:47:05.867 INFO [stderr]    Compiling tokio-threadpool v0.1.4
Nov 16 12:47:07.768 INFO [stderr]    Compiling tokio-codec v0.1.0
Nov 16 12:47:10.081 INFO [stderr]    Compiling crossbeam-channel v0.2.1
Nov 16 12:47:11.623 INFO [stderr]    Compiling tokio-reactor v0.1.2
Nov 16 12:47:14.595 INFO [stderr]    Compiling tokio-fs v0.1.1
Nov 16 12:47:16.803 INFO [stderr]    Compiling tokio-tcp v0.1.0
Nov 16 12:47:17.319 INFO [stderr]    Compiling tokio-udp v0.1.1
Nov 16 12:47:17.494 INFO [stderr]    Compiling native-tls v0.1.5
Nov 16 12:47:18.799 INFO [stderr]    Compiling tokio v0.1.7
Nov 16 12:47:21.659 INFO [stderr]    Compiling tokio-core v0.1.17
Nov 16 12:47:26.097 INFO [stderr]    Compiling tokio-tls v0.1.4
Nov 16 12:47:56.571 INFO [stderr]    Compiling zstd-safe v1.4.3+zstd.1.3.4
Nov 16 12:47:57.081 INFO [stderr]    Compiling zstd v0.4.18+zstd.1.3.4
Nov 16 12:47:57.757 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Nov 16 12:47:58.375 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 12:47:58.375 INFO [stderr]  --> src/main.rs:5:1
Nov 16 12:47:58.375 INFO [stderr]   |
Nov 16 12:47:58.375 INFO [stderr] 5 | #[macro_use]
Nov 16 12:47:58.375 INFO [stderr]   | ^^^^^^^^^^^^
Nov 16 12:47:58.375 INFO [stderr]   |
Nov 16 12:47:58.375 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 12:47:58.375 INFO [stderr] 
Nov 16 12:47:58.518 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Nov 16 12:47:58.518 INFO [stderr]   --> src/server.rs:31:40
Nov 16 12:47:58.518 INFO [stderr]    |
Nov 16 12:47:58.518 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Nov 16 12:47:58.518 INFO [stderr]    |                                        ^^^^^^
Nov 16 12:47:58.518 INFO [stderr]    |
Nov 16 12:47:58.518 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 16 12:47:58.518 INFO [stderr] 
Nov 16 12:47:58.533 INFO [stderr] warning: unused variable: `page_size`
Nov 16 12:47:58.533 INFO [stderr]   --> src/main.rs:25:9
Nov 16 12:47:58.534 INFO [stderr]    |
Nov 16 12:47:58.534 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Nov 16 12:47:58.534 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Nov 16 12:47:58.534 INFO [stderr]    |
Nov 16 12:47:58.534 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 12:47:58.535 INFO [stderr] 
Nov 16 12:47:58.564 INFO [stderr] warning: field is never used: `map`
Nov 16 12:47:58.564 INFO [stderr]   --> src/hash/mod.rs:10:5
Nov 16 12:47:58.564 INFO [stderr]    |
Nov 16 12:47:58.564 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Nov 16 12:47:58.564 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.564 INFO [stderr]    |
Nov 16 12:47:58.564 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 12:47:58.564 INFO [stderr] 
Nov 16 12:47:58.564 INFO [stderr] warning: method is never used: `get`
Nov 16 12:47:58.564 INFO [stderr]   --> src/hash/mod.rs:20:5
Nov 16 12:47:58.564 INFO [stderr]    |
Nov 16 12:47:58.564 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Nov 16 12:47:58.565 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.565 INFO [stderr] 
Nov 16 12:47:58.565 INFO [stderr] warning: method is never used: `put`
Nov 16 12:47:58.565 INFO [stderr]   --> src/hash/mod.rs:24:5
Nov 16 12:47:58.565 INFO [stderr]    |
Nov 16 12:47:58.565 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Nov 16 12:47:58.565 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.565 INFO [stderr] 
Nov 16 12:47:58.565 INFO [stderr] warning: method is never used: `del`
Nov 16 12:47:58.565 INFO [stderr]   --> src/hash/mod.rs:28:5
Nov 16 12:47:58.566 INFO [stderr]    |
Nov 16 12:47:58.566 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Nov 16 12:47:58.566 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.566 INFO [stderr] 
Nov 16 12:47:58.566 INFO [stderr] warning: method is never used: `query`
Nov 16 12:47:58.566 INFO [stderr]   --> src/hash/mod.rs:32:5
Nov 16 12:47:58.566 INFO [stderr]    |
Nov 16 12:47:58.566 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Nov 16 12:47:58.566 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.566 INFO [stderr] 
Nov 16 12:47:58.567 INFO [stderr] warning: method is never used: `new`
Nov 16 12:47:58.567 INFO [stderr]   --> src/query.rs:22:5
Nov 16 12:47:58.567 INFO [stderr]    |
Nov 16 12:47:58.567 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Nov 16 12:47:58.567 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:47:58.567 INFO [stderr] 
Nov 16 12:47:58.571 INFO [stderr] warning: field is never used: `db`
Nov 16 12:47:58.571 INFO [stderr]   --> src/server.rs:12:5
Nov 16 12:47:58.571 INFO [stderr]    |
Nov 16 12:47:58.571 INFO [stderr] 12 |     db: OpalDb,
Nov 16 12:47:58.571 INFO [stderr]    |     ^^^^^^^^^^
Nov 16 12:47:58.571 INFO [stderr] 
Nov 16 12:47:58.571 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.571 INFO [stderr]  --> src/main.rs:1:12
Nov 16 12:47:58.571 INFO [stderr]   |
Nov 16 12:47:58.571 INFO [stderr] 1 | #![feature(extern_prelude)]
Nov 16 12:47:58.571 INFO [stderr]   |            ^^^^^^^^^^^^^^
Nov 16 12:47:58.571 INFO [stderr]   |
Nov 16 12:47:58.571 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 16 12:47:58.571 INFO [stderr] 
Nov 16 12:48:00.070 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 04s
Nov 16 12:48:00.080 INFO [stderr] su: No module specific data is present
Nov 16 12:48:00.417 INFO running `"docker" "inspect" "8d722231e17bd2f05dada60cab8ac9dd955a1b735b5e9d685e03b8cb715c214c"`
Nov 16 12:48:00.608 INFO running `"docker" "rm" "-f" "8d722231e17bd2f05dada60cab8ac9dd955a1b735b5e9d685e03b8cb715c214c"`
Nov 16 12:48:00.766 INFO [stdout] 8d722231e17bd2f05dada60cab8ac9dd955a1b735b5e9d685e03b8cb715c214c
Nov 16 12:48:00.768 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 16 12:48:01.097 INFO [stdout] fd8786245373f3ccd1a6dcc1ecc4933701ee67847c7a043aad42f5fc1d614e63
Nov 16 12:48:01.099 INFO running `"docker" "start" "-a" "fd8786245373f3ccd1a6dcc1ecc4933701ee67847c7a043aad42f5fc1d614e63"`
Nov 16 12:48:01.477 INFO [stderr] usermod: no changes
Nov 16 12:48:01.616 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Nov 16 12:48:02.182 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 12:48:02.182 INFO [stderr]  --> src/main.rs:5:1
Nov 16 12:48:02.182 INFO [stderr]   |
Nov 16 12:48:02.182 INFO [stderr] 5 | #[macro_use]
Nov 16 12:48:02.182 INFO [stderr]   | ^^^^^^^^^^^^
Nov 16 12:48:02.182 INFO [stderr]   |
Nov 16 12:48:02.182 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 12:48:02.182 INFO [stderr] 
Nov 16 12:48:02.331 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Nov 16 12:48:02.331 INFO [stderr]   --> src/server.rs:31:40
Nov 16 12:48:02.331 INFO [stderr]    |
Nov 16 12:48:02.331 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Nov 16 12:48:02.331 INFO [stderr]    |                                        ^^^^^^
Nov 16 12:48:02.331 INFO [stderr]    |
Nov 16 12:48:02.331 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 16 12:48:02.331 INFO [stderr] 
Nov 16 12:48:02.351 INFO [stderr] warning: unused variable: `page_size`
Nov 16 12:48:02.351 INFO [stderr]   --> src/main.rs:25:9
Nov 16 12:48:02.351 INFO [stderr]    |
Nov 16 12:48:02.351 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Nov 16 12:48:02.351 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Nov 16 12:48:02.351 INFO [stderr]    |
Nov 16 12:48:02.351 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 12:48:02.351 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: field is never used: `map`
Nov 16 12:48:02.391 INFO [stderr]   --> src/hash/mod.rs:10:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: method is never used: `get`
Nov 16 12:48:02.391 INFO [stderr]   --> src/hash/mod.rs:20:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: method is never used: `put`
Nov 16 12:48:02.391 INFO [stderr]   --> src/hash/mod.rs:24:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: method is never used: `del`
Nov 16 12:48:02.391 INFO [stderr]   --> src/hash/mod.rs:28:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: method is never used: `query`
Nov 16 12:48:02.391 INFO [stderr]   --> src/hash/mod.rs:32:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: method is never used: `new`
Nov 16 12:48:02.391 INFO [stderr]   --> src/query.rs:22:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 INFO [stderr] warning: field is never used: `db`
Nov 16 12:48:02.391 INFO [stderr]   --> src/server.rs:12:5
Nov 16 12:48:02.391 INFO [stderr]    |
Nov 16 12:48:02.391 INFO [stderr] 12 |     db: OpalDb,
Nov 16 12:48:02.391 INFO [stderr]    |     ^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.391 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.391 INFO [stderr]  --> src/main.rs:1:12
Nov 16 12:48:02.391 INFO [stderr]   |
Nov 16 12:48:02.391 INFO [stderr] 1 | #![feature(extern_prelude)]
Nov 16 12:48:02.391 INFO [stderr]   |            ^^^^^^^^^^^^^^
Nov 16 12:48:02.391 INFO [stderr]   |
Nov 16 12:48:02.391 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 16 12:48:02.391 INFO [stderr] 
Nov 16 12:48:02.710 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.21s
Nov 16 12:48:02.719 INFO [stderr] su: No module specific data is present
Nov 16 12:48:03.228 INFO running `"docker" "inspect" "fd8786245373f3ccd1a6dcc1ecc4933701ee67847c7a043aad42f5fc1d614e63"`
Nov 16 12:48:03.304 INFO running `"docker" "rm" "-f" "fd8786245373f3ccd1a6dcc1ecc4933701ee67847c7a043aad42f5fc1d614e63"`
Nov 16 12:48:03.384 INFO [stdout] fd8786245373f3ccd1a6dcc1ecc4933701ee67847c7a043aad42f5fc1d614e63
Nov 16 12:48:03.386 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 16 12:48:03.609 INFO [stdout] 1977d200d473f6ca2584cb20876da818a1280343fc4d6851cf2626aa49d92008
Nov 16 12:48:03.612 INFO running `"docker" "start" "-a" "1977d200d473f6ca2584cb20876da818a1280343fc4d6851cf2626aa49d92008"`
Nov 16 12:48:04.055 INFO [stderr] usermod: no changes
Nov 16 12:48:04.171 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 16 12:48:04.176 INFO [stderr]      Running /target/debug/deps/opalkv-7542839313d56f24
Nov 16 12:48:04.179 INFO [stdout] 
Nov 16 12:48:04.179 INFO [stdout] running 0 tests
Nov 16 12:48:04.179 INFO [stdout] 
Nov 16 12:48:04.179 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 12:48:04.179 INFO [stdout] 
Nov 16 12:48:04.180 INFO [stderr] su: No module specific data is present
Nov 16 12:48:04.439 INFO running `"docker" "inspect" "1977d200d473f6ca2584cb20876da818a1280343fc4d6851cf2626aa49d92008"`
Nov 16 12:48:04.522 INFO running `"docker" "rm" "-f" "1977d200d473f6ca2584cb20876da818a1280343fc4d6851cf2626aa49d92008"`
Nov 16 12:48:04.622 INFO [stdout] 1977d200d473f6ca2584cb20876da818a1280343fc4d6851cf2626aa49d92008