Dec 13 02:33:21.291 INFO testing sourgrasses/opalkv against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 02:33:21.291 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 02:33:21.647 INFO [stdout] 1a0c483a33005381066fea904a41da410f961d5759177279217bbcd0785c2739
Dec 13 02:33:21.649 INFO running `"docker" "start" "-a" "1a0c483a33005381066fea904a41da410f961d5759177279217bbcd0785c2739"`
Dec 13 02:33:22.654 INFO [stderr] usermod: no changes
Dec 13 02:33:22.901 INFO [stderr]    Compiling openssl-sys v0.9.33
Dec 13 02:33:22.901 INFO [stderr]    Compiling zstd-sys v1.4.3+zstd.1.3.4
Dec 13 02:33:22.906 INFO [stderr]    Compiling mio v0.6.14
Dec 13 02:33:22.906 INFO [stderr]    Compiling tokio-io v0.1.7
Dec 13 02:33:22.906 INFO [stderr]    Compiling tokio-threadpool v0.1.4
Dec 13 02:33:22.906 INFO [stderr]    Compiling crossbeam-channel v0.2.1
Dec 13 02:33:29.381 INFO [stderr]    Compiling tokio-codec v0.1.0
Dec 13 02:33:29.427 INFO [stderr]    Compiling openssl v0.9.24
Dec 13 02:33:32.711 INFO [stderr]    Compiling tokio-reactor v0.1.2
Dec 13 02:33:34.640 INFO [stderr]    Compiling tokio-fs v0.1.1
Dec 13 02:33:36.729 INFO [stderr]    Compiling tokio-udp v0.1.1
Dec 13 02:33:36.730 INFO [stderr]    Compiling tokio-tcp v0.1.0
Dec 13 02:33:39.655 INFO [stderr]    Compiling tokio v0.1.7
Dec 13 02:33:44.667 INFO [stderr]    Compiling tokio-core v0.1.17
Dec 13 02:33:47.001 INFO [stderr]    Compiling native-tls v0.1.5
Dec 13 02:33:50.943 INFO [stderr]    Compiling tokio-tls v0.1.4
Dec 13 02:34:24.985 INFO [stderr]    Compiling zstd-safe v1.4.3+zstd.1.3.4
Dec 13 02:34:25.601 INFO [stderr]    Compiling zstd v0.4.18+zstd.1.3.4
Dec 13 02:34:26.411 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Dec 13 02:34:27.213 INFO [stderr] warning: unused `#[macro_use]` import
Dec 13 02:34:27.213 INFO [stderr]  --> src/main.rs:5:1
Dec 13 02:34:27.213 INFO [stderr]   |
Dec 13 02:34:27.213 INFO [stderr] 5 | #[macro_use]
Dec 13 02:34:27.213 INFO [stderr]   | ^^^^^^^^^^^^
Dec 13 02:34:27.213 INFO [stderr]   |
Dec 13 02:34:27.213 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 13 02:34:27.213 INFO [stderr] 
Dec 13 02:34:27.383 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Dec 13 02:34:27.383 INFO [stderr]   --> src/server.rs:31:40
Dec 13 02:34:27.383 INFO [stderr]    |
Dec 13 02:34:27.383 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Dec 13 02:34:27.383 INFO [stderr]    |                                        ^^^^^^
Dec 13 02:34:27.383 INFO [stderr]    |
Dec 13 02:34:27.383 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 13 02:34:27.383 INFO [stderr] 
Dec 13 02:34:27.403 INFO [stderr] warning: unused variable: `page_size`
Dec 13 02:34:27.403 INFO [stderr]   --> src/main.rs:25:9
Dec 13 02:34:27.403 INFO [stderr]    |
Dec 13 02:34:27.403 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Dec 13 02:34:27.403 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Dec 13 02:34:27.403 INFO [stderr]    |
Dec 13 02:34:27.403 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 13 02:34:27.403 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: field is never used: `map`
Dec 13 02:34:27.447 INFO [stderr]   --> src/hash/mod.rs:10:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: method is never used: `get`
Dec 13 02:34:27.447 INFO [stderr]   --> src/hash/mod.rs:20:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: method is never used: `put`
Dec 13 02:34:27.447 INFO [stderr]   --> src/hash/mod.rs:24:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: method is never used: `del`
Dec 13 02:34:27.447 INFO [stderr]   --> src/hash/mod.rs:28:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: method is never used: `query`
Dec 13 02:34:27.447 INFO [stderr]   --> src/hash/mod.rs:32:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: method is never used: `new`
Dec 13 02:34:27.447 INFO [stderr]   --> src/query.rs:22:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: field is never used: `db`
Dec 13 02:34:27.447 INFO [stderr]   --> src/server.rs:12:5
Dec 13 02:34:27.447 INFO [stderr]    |
Dec 13 02:34:27.447 INFO [stderr] 12 |     db: OpalDb,
Dec 13 02:34:27.447 INFO [stderr]    |     ^^^^^^^^^^
Dec 13 02:34:27.447 INFO [stderr] 
Dec 13 02:34:27.447 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Dec 13 02:34:27.447 INFO [stderr]  --> src/main.rs:1:12
Dec 13 02:34:27.447 INFO [stderr]   |
Dec 13 02:34:27.448 INFO [stderr] 1 | #![feature(extern_prelude)]
Dec 13 02:34:27.448 INFO [stderr]   |            ^^^^^^^^^^^^^^
Dec 13 02:34:27.448 INFO [stderr]   |
Dec 13 02:34:27.448 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 13 02:34:27.448 INFO [stderr] 
Dec 13 02:34:29.409 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 06s
Dec 13 02:34:29.418 INFO [stderr] su: No module specific data is present
Dec 13 02:34:30.752 INFO running `"docker" "inspect" "1a0c483a33005381066fea904a41da410f961d5759177279217bbcd0785c2739"`
Dec 13 02:34:31.123 INFO running `"docker" "rm" "-f" "1a0c483a33005381066fea904a41da410f961d5759177279217bbcd0785c2739"`
Dec 13 02:34:31.427 INFO [stdout] 1a0c483a33005381066fea904a41da410f961d5759177279217bbcd0785c2739
Dec 13 02:34:31.435 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 02:34:32.002 INFO [stdout] db9f913af291ee3fb0d0a34450716c5ffbf24783f141ae8e49100f6e3e41626c
Dec 13 02:34:32.004 INFO running `"docker" "start" "-a" "db9f913af291ee3fb0d0a34450716c5ffbf24783f141ae8e49100f6e3e41626c"`
Dec 13 02:34:33.971 INFO [stderr] usermod: no changes
Dec 13 02:34:34.191 INFO [stderr]    Compiling opalkv v0.1.0 (/source)
Dec 13 02:34:35.016 INFO [stderr] warning: unused `#[macro_use]` import
Dec 13 02:34:35.016 INFO [stderr]  --> src/main.rs:5:1
Dec 13 02:34:35.016 INFO [stderr]   |
Dec 13 02:34:35.016 INFO [stderr] 5 | #[macro_use]
Dec 13 02:34:35.016 INFO [stderr]   | ^^^^^^^^^^^^
Dec 13 02:34:35.016 INFO [stderr]   |
Dec 13 02:34:35.016 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 13 02:34:35.016 INFO [stderr] 
Dec 13 02:34:35.155 INFO [stderr] warning: use of deprecated item 'tokio::io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Dec 13 02:34:35.155 INFO [stderr]   --> src/server.rs:31:40
Dec 13 02:34:35.155 INFO [stderr]    |
Dec 13 02:34:35.155 INFO [stderr] 31 |                 let framed_sock = sock.framed(QueryCodec::new());
Dec 13 02:34:35.155 INFO [stderr]    |                                        ^^^^^^
Dec 13 02:34:35.155 INFO [stderr]    |
Dec 13 02:34:35.155 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 13 02:34:35.155 INFO [stderr] 
Dec 13 02:34:35.167 INFO [stderr] warning: unused variable: `page_size`
Dec 13 02:34:35.167 INFO [stderr]   --> src/main.rs:25:9
Dec 13 02:34:35.167 INFO [stderr]    |
Dec 13 02:34:35.167 INFO [stderr] 25 |     let page_size: i64 = unsafe {
Dec 13 02:34:35.167 INFO [stderr]    |         ^^^^^^^^^ help: consider using `_page_size` instead
Dec 13 02:34:35.167 INFO [stderr]    |
Dec 13 02:34:35.167 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 13 02:34:35.167 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: field is never used: `map`
Dec 13 02:34:35.203 INFO [stderr]   --> src/hash/mod.rs:10:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 10 |     map: BTreeMap<Bytes, Bytes>
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: method is never used: `get`
Dec 13 02:34:35.203 INFO [stderr]   --> src/hash/mod.rs:20:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 20 |     fn get(&self, k: &Bytes) -> Option<&Bytes> {
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: method is never used: `put`
Dec 13 02:34:35.203 INFO [stderr]   --> src/hash/mod.rs:24:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 24 |     fn put(&mut self, k: &Bytes, v: &Bytes) -> Option<Bytes> {
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: method is never used: `del`
Dec 13 02:34:35.203 INFO [stderr]   --> src/hash/mod.rs:28:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 28 |     fn del(&mut self, k: &Bytes) -> Option<Bytes> {
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: method is never used: `query`
Dec 13 02:34:35.203 INFO [stderr]   --> src/hash/mod.rs:32:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 32 |     pub fn query(&mut self, msg: &Query) -> Result<Option<Bytes>, io::Error> {
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: method is never used: `new`
Dec 13 02:34:35.203 INFO [stderr]   --> src/query.rs:22:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 22 |     pub fn new(qtype: QueryType, key: Bytes, value: Option<Bytes>) -> Query {
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: field is never used: `db`
Dec 13 02:34:35.203 INFO [stderr]   --> src/server.rs:12:5
Dec 13 02:34:35.203 INFO [stderr]    |
Dec 13 02:34:35.203 INFO [stderr] 12 |     db: OpalDb,
Dec 13 02:34:35.203 INFO [stderr]    |     ^^^^^^^^^^
Dec 13 02:34:35.203 INFO [stderr] 
Dec 13 02:34:35.203 INFO [stderr] warning: the feature `extern_prelude` has been stable since 1.30.0 and no longer requires an attribute to enable
Dec 13 02:34:35.204 INFO [stderr]  --> src/main.rs:1:12
Dec 13 02:34:35.204 INFO [stderr]   |
Dec 13 02:34:35.204 INFO [stderr] 1 | #![feature(extern_prelude)]
Dec 13 02:34:35.204 INFO [stderr]   |            ^^^^^^^^^^^^^^
Dec 13 02:34:35.204 INFO [stderr]   |
Dec 13 02:34:35.204 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 13 02:34:35.204 INFO [stderr] 
Dec 13 02:34:35.711 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.69s
Dec 13 02:34:35.719 INFO [stderr] su: No module specific data is present
Dec 13 02:34:37.229 INFO running `"docker" "inspect" "db9f913af291ee3fb0d0a34450716c5ffbf24783f141ae8e49100f6e3e41626c"`
Dec 13 02:34:37.600 INFO running `"docker" "rm" "-f" "db9f913af291ee3fb0d0a34450716c5ffbf24783f141ae8e49100f6e3e41626c"`
Dec 13 02:34:37.924 INFO [stdout] db9f913af291ee3fb0d0a34450716c5ffbf24783f141ae8e49100f6e3e41626c
Dec 13 02:34:37.928 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 02:34:38.327 INFO [stdout] 56bf1951b91e5683d7172e56c15de27334d7db525ea8690c9dfec5f5d29d5b8b
Dec 13 02:34:38.329 INFO running `"docker" "start" "-a" "56bf1951b91e5683d7172e56c15de27334d7db525ea8690c9dfec5f5d29d5b8b"`
Dec 13 02:34:40.114 INFO [stderr] usermod: no changes
Dec 13 02:34:40.299 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 13 02:34:40.305 INFO [stderr]      Running /target/debug/deps/opalkv-41f4995bdb8c3da3
Dec 13 02:34:40.308 INFO [stdout] 
Dec 13 02:34:40.308 INFO [stdout] running 0 tests
Dec 13 02:34:40.308 INFO [stdout] 
Dec 13 02:34:40.308 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 02:34:40.308 INFO [stdout] 
Dec 13 02:34:40.311 INFO [stderr] su: No module specific data is present
Dec 13 02:34:41.471 INFO running `"docker" "inspect" "56bf1951b91e5683d7172e56c15de27334d7db525ea8690c9dfec5f5d29d5b8b"`
Dec 13 02:34:41.820 INFO running `"docker" "rm" "-f" "56bf1951b91e5683d7172e56c15de27334d7db525ea8690c9dfec5f5d29d5b8b"`
Dec 13 02:34:42.150 INFO [stdout] 56bf1951b91e5683d7172e56c15de27334d7db525ea8690c9dfec5f5d29d5b8b