[INFO] fetching crate feophant 0.9.0...
[INFO] testing feophant-0.9.0 against try#1b74e096b9bfb06f84a3007193dcd2f059cbdf6a for pr-96025
[INFO] extracting crate feophant 0.9.0 into /workspace/builds/worker-96/source
[INFO] validating manifest of crates.io crate feophant 0.9.0 on toolchain 1b74e096b9bfb06f84a3007193dcd2f059cbdf6a
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate feophant 0.9.0
[INFO] finished tweaking crates.io crate feophant 0.9.0
[INFO] tweaked toml for crates.io crate feophant 0.9.0 written to /workspace/builds/worker-96/source/Cargo.toml
[INFO] crate crates.io crate feophant 0.9.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1837a60c53bf82f1e9021e97c846abe0e5ccf887fbfc43c43392c2b242c9509b
[INFO] running `Command { std: "docker" "start" "-a" "1837a60c53bf82f1e9021e97c846abe0e5ccf887fbfc43c43392c2b242c9509b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1837a60c53bf82f1e9021e97c846abe0e5ccf887fbfc43c43392c2b242c9509b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1837a60c53bf82f1e9021e97c846abe0e5ccf887fbfc43c43392c2b242c9509b", kill_on_drop: false }`
[INFO] [stdout] 1837a60c53bf82f1e9021e97c846abe0e5ccf887fbfc43c43392c2b242c9509b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a0234eec8e831a4cd77fd526f49ae7b1e70032bbd73f16928c4b1030b91db128
[INFO] running `Command { std: "docker" "start" "-a" "a0234eec8e831a4cd77fd526f49ae7b1e70032bbd73f16928c4b1030b91db128", kill_on_drop: false }`
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling libc v0.2.97
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling futures-core v0.3.15
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling smallvec v1.6.1
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling futures-sink v0.3.15
[INFO] [stderr]    Compiling futures-task v0.3.15
[INFO] [stderr]    Compiling futures-io v0.3.15
[INFO] [stderr]    Compiling proc-macro-nested v0.1.7
[INFO] [stderr]    Compiling futures-channel v0.3.15
[INFO] [stderr]    Compiling crossbeam-utils v0.8.5
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling slab v0.4.3
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling cache-padded v1.1.1
[INFO] [stderr]    Compiling waker-fn v1.1.0
[INFO] [stderr]    Compiling parking v2.0.0
[INFO] [stderr]    Compiling fastrand v1.5.0
[INFO] [stderr]    Compiling minimal-lexical v0.1.2
[INFO] [stderr]    Compiling bytes v1.0.1
[INFO] [stderr]    Compiling event-listener v2.5.1
[INFO] [stderr]    Compiling moka v0.6.1
[INFO] [stderr]    Compiling termcolor v1.1.2
[INFO] [stderr]    Compiling hex-literal v0.3.1
[INFO] [stderr]    Compiling concurrent-queue v1.2.2
[INFO] [stderr]    Compiling instant v0.1.9
[INFO] [stderr]    Compiling lock_api v0.4.4
[INFO] [stderr]    Compiling async-lock v2.4.0
[INFO] [stderr]    Compiling ahash v0.7.4
[INFO] [stderr]    Compiling nom v7.0.0
[INFO] [stderr]    Compiling futures-macro v0.3.15
[INFO] [stderr]    Compiling memoffset v0.5.6
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling futures-util v0.3.15
[INFO] [stderr]    Compiling crossbeam-utils v0.7.2
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling tokio v1.7.1
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling raw-cpuid v10.2.0
[INFO] [stderr]    Compiling futures-lite v1.12.0
[INFO] [stderr]    Compiling crossbeam-channel v0.5.1
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling parking_lot_core v0.8.3
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[INFO] [stderr]    Compiling mio v0.7.13
[INFO] [stderr]    Compiling socket2 v0.4.1
[INFO] [stderr]    Compiling polling v2.1.0
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling uuid v0.8.2
[INFO] [stderr]    Compiling parking_lot v0.11.1
[INFO] [stderr]    Compiling quanta v0.9.3
[INFO] [stderr]    Compiling async-io v1.6.0
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling scheduled-thread-pool v0.2.5
[INFO] [stderr]    Compiling moka-cht v0.4.2
[INFO] [stderr]    Compiling lru v0.6.6
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling simplelog v0.10.0
[INFO] [stderr]    Compiling tokio-macros v1.2.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.25
[INFO] [stderr]    Compiling async-stream-impl v0.3.2
[INFO] [stderr]    Compiling async-stream v0.3.2
[INFO] [stderr]    Compiling thiserror v1.0.25
[INFO] [stderr]    Compiling futures-executor v0.3.15
[INFO] [stderr]    Compiling futures v0.3.15
[INFO] [stderr]    Compiling tokio-util v0.6.7
[INFO] [stderr]    Compiling tokio-stream v0.1.6
[INFO] [stderr]    Compiling feophant v0.9.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused imports: `BytesMut`, `Bytes`
[INFO] [stdout]   --> src/engine/io/row_formats/item_pointer.rs:11:26
[INFO] [stdout]    |
[INFO] [stdout] 11 | use bytes::{Buf, BufMut, Bytes, BytesMut};
[INFO] [stdout]    |                          ^^^^^  ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::convert::TryFrom`
[INFO] [stdout]   --> src/engine/io/row_formats/item_pointer.rs:12:5
[INFO] [stdout]    |
[INFO] [stdout] 12 | use std::convert::TryFrom;
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `page_offset`
[INFO] [stdout]   --> src/engine/io/index_manager.rs:66:26
[INFO] [stdout]    |
[INFO] [stdout] 66 |         let (page_guard, page_offset, mut leaf) =
[INFO] [stdout]    |                          ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_page_offset`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `o`
[INFO] [stdout]   --> src/engine/io/visible_row_manager.rs:89:20
[INFO] [stdout]    |
[INFO] [stdout] 89 |                 Ok(o) => return Ok(true),
[INFO] [stdout]    |                    ^ help: if this is intentional, prefix it with an underscore: `_o`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `k`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_leaf.rs:146:25
[INFO] [stdout]     |
[INFO] [stdout] 146 |             .flat_map(|(k, v)| v.clone())
[INFO] [stdout]     |                         ^ help: if this is intentional, prefix it with an underscore: `_k`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `prior_offset` is assigned to, but never used
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:33:13
[INFO] [stdout]    |
[INFO] [stdout] 33 |     let mut prior_offset = PageOffset(0);
[INFO] [stdout]    |             ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: consider using `_prior_offset` instead
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `prior_offset` is never read
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:60:21
[INFO] [stdout]    |
[INFO] [stdout] 60 |                     prior_offset = offset;
[INFO] [stdout]    |                     ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stdout]    = help: maybe it is overwritten before being read?
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `a`
[INFO] [stdout]    --> src/engine/objects/types/base_sql_types.rs:117:39
[INFO] [stdout]     |
[INFO] [stdout] 117 |             BaseSqlTypesMapper::Array(a) => todo!("Bed time, need to fix!"),
[INFO] [stdout]     |                                       ^ help: if this is intentional, prefix it with an underscore: `_a`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `file_manager`
[INFO] [stdout]   --> src/feophant.rs:28:5
[INFO] [stdout]    |
[INFO] [stdout] 28 |     file_manager: Arc<FileManager2>,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `search`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_leaf.rs:140:12
[INFO] [stdout]     |
[INFO] [stdout] 140 |     pub fn search<R>(&self, range: R) -> Vec<ItemPointer>
[INFO] [stdout]     |            ^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `parse_constraint`
[INFO] [stdout]  --> src/engine/objects/constraints/parse_constraint.rs:9:8
[INFO] [stdout]   |
[INFO] [stdout] 9 | pub fn parse_constraint<'a, E: ParseError<&'a str> + ContextError<&'a str>>(
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 11 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.35s
[INFO] running `Command { std: "docker" "inspect" "a0234eec8e831a4cd77fd526f49ae7b1e70032bbd73f16928c4b1030b91db128", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a0234eec8e831a4cd77fd526f49ae7b1e70032bbd73f16928c4b1030b91db128", kill_on_drop: false }`
[INFO] [stdout] a0234eec8e831a4cd77fd526f49ae7b1e70032bbd73f16928c4b1030b91db128
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 474646b805d2aaf155e8bd1c883fd3d7d6f89c334aef13c33d1b5db17225eeff
[INFO] running `Command { std: "docker" "start" "-a" "474646b805d2aaf155e8bd1c883fd3d7d6f89c334aef13c33d1b5db17225eeff", kill_on_drop: false }`
[INFO] [stderr]    Compiling typenum v1.13.0
[INFO] [stderr]    Compiling serde_derive v1.0.127
[INFO] [stderr]    Compiling serde v1.0.127
[INFO] [stderr]    Compiling semver v1.0.4
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.5
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling subtle v2.4.1
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling rayon-core v1.9.1
[INFO] [stderr]    Compiling itoa v0.4.7
[INFO] [stderr]    Compiling cpufeatures v0.1.5
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling serde_json v1.0.66
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling siphasher v0.3.6
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling plotters-backend v0.3.2
[INFO] [stderr]    Compiling async-trait v0.1.51
[INFO] [stderr]    Compiling half v1.7.1
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling oorandom v11.1.3
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling percent-encoding v2.1.0
[INFO] [stderr]    Compiling memoffset v0.6.4
[INFO] [stderr]    Compiling rayon v1.5.1
[INFO] [stderr]    Compiling generic-array v0.14.4
[INFO] [stderr]    Compiling csv-core v0.1.10
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling tokio-test v0.4.2
[INFO] [stdout] warning: unused imports: `BytesMut`, `Bytes`
[INFO] [stdout]   --> src/engine/io/row_formats/item_pointer.rs:11:26
[INFO] [stdout]    |
[INFO] [stdout] 11 | use bytes::{Buf, BufMut, Bytes, BytesMut};
[INFO] [stdout]    |                          ^^^^^  ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::convert::TryFrom`
[INFO] [stdout]   --> src/engine/io/row_formats/item_pointer.rs:12:5
[INFO] [stdout]    |
[INFO] [stdout] 12 | use std::convert::TryFrom;
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `page_offset`
[INFO] [stdout]   --> src/engine/io/index_manager.rs:66:26
[INFO] [stdout]    |
[INFO] [stdout] 66 |         let (page_guard, page_offset, mut leaf) =
[INFO] [stdout]    |                          ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_page_offset`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `o`
[INFO] [stdout]   --> src/engine/io/visible_row_manager.rs:89:20
[INFO] [stdout]    |
[INFO] [stdout] 89 |                 Ok(o) => return Ok(true),
[INFO] [stdout]    |                    ^ help: if this is intentional, prefix it with an underscore: `_o`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `k`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_leaf.rs:146:25
[INFO] [stdout]     |
[INFO] [stdout] 146 |             .flat_map(|(k, v)| v.clone())
[INFO] [stdout]     |                         ^ help: if this is intentional, prefix it with an underscore: `_k`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `prior_offset` is assigned to, but never used
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:33:13
[INFO] [stdout]    |
[INFO] [stdout] 33 |     let mut prior_offset = PageOffset(0);
[INFO] [stdout]    |             ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: consider using `_prior_offset` instead
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `prior_offset` is never read
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:60:21
[INFO] [stdout]    |
[INFO] [stdout] 60 |                     prior_offset = offset;
[INFO] [stdout]    |                     ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stdout]    = help: maybe it is overwritten before being read?
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `a`
[INFO] [stdout]    --> src/engine/objects/types/base_sql_types.rs:117:39
[INFO] [stdout]     |
[INFO] [stdout] 117 |             BaseSqlTypesMapper::Array(a) => todo!("Bed time, need to fix!"),
[INFO] [stdout]     |                                       ^ help: if this is intentional, prefix it with an underscore: `_a`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `file_manager`
[INFO] [stdout]   --> src/feophant.rs:28:5
[INFO] [stdout]    |
[INFO] [stdout] 28 |     file_manager: Arc<FileManager2>,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function is never used: `search`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_leaf.rs:140:12
[INFO] [stdout]     |
[INFO] [stdout] 140 |     pub fn search<R>(&self, range: R) -> Vec<ItemPointer>
[INFO] [stdout]     |            ^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `parse_constraint`
[INFO] [stdout]  --> src/engine/objects/constraints/parse_constraint.rs:9:8
[INFO] [stdout]   |
[INFO] [stdout] 9 | pub fn parse_constraint<'a, E: ParseError<&'a str> + ContextError<&'a str>>(
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 11 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling unicode-bidi v0.3.5
[INFO] [stderr]    Compiling tinyvec v1.3.1
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling phf_shared v0.8.0
[INFO] [stderr]    Compiling plotters-svg v0.3.1
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling plotters v0.3.1
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling phf v0.8.0
[INFO] [stderr]    Compiling itertools v0.10.1
[INFO] [stderr]    Compiling rustc_version v0.4.0
[INFO] [stderr]    Compiling tempfile v3.2.0
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling cast v0.2.7
[INFO] [stderr]    Compiling crossbeam-deque v0.8.1
[INFO] [stderr]    Compiling stringprep v0.1.2
[INFO] [stderr]    Compiling criterion-plot v0.4.4
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling crypto-mac v0.10.1
[INFO] [stderr]    Compiling md-5 v0.9.1
[INFO] [stderr]    Compiling sha2 v0.9.5
[INFO] [stderr]    Compiling hmac v0.10.1
[INFO] [stderr]    Compiling postgres-protocol v0.6.1
[INFO] [stderr]    Compiling postgres-types v0.2.1
[INFO] [stderr]    Compiling tokio-postgres v0.7.2
[INFO] [stderr]    Compiling bstr v0.2.15
[INFO] [stderr]    Compiling serde_cbor v0.11.1
[INFO] [stderr]    Compiling csv v1.1.6
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.3.5
[INFO] [stderr]    Compiling feophant v0.9.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `super::*`
[INFO] [stdout]   --> src/engine/io/block_layer/lock_manager.rs:65:9
[INFO] [stdout]    |
[INFO] [stdout] 65 |     use super::*;
[INFO] [stdout]    |         ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::convert::TryFrom`
[INFO] [stdout]   --> src/engine/io/row_formats/item_pointer.rs:12:5
[INFO] [stdout]    |
[INFO] [stdout] 12 | use std::convert::TryFrom;
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `page_offset`
[INFO] [stdout]   --> src/engine/io/index_manager.rs:66:26
[INFO] [stdout]    |
[INFO] [stdout] 66 |         let (page_guard, page_offset, mut leaf) =
[INFO] [stdout]    |                          ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_page_offset`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `o`
[INFO] [stdout]   --> src/engine/io/visible_row_manager.rs:89:20
[INFO] [stdout]    |
[INFO] [stdout] 89 |                 Ok(o) => return Ok(true),
[INFO] [stdout]    |                    ^ help: if this is intentional, prefix it with an underscore: `_o`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `k`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_leaf.rs:146:25
[INFO] [stdout]     |
[INFO] [stdout] 146 |             .flat_map(|(k, v)| v.clone())
[INFO] [stdout]     |                         ^ help: if this is intentional, prefix it with an underscore: `_k`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `prior_offset` is assigned to, but never used
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:33:13
[INFO] [stdout]    |
[INFO] [stdout] 33 |     let mut prior_offset = PageOffset(0);
[INFO] [stdout]    |             ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: consider using `_prior_offset` instead
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `prior_offset` is never read
[INFO] [stdout]   --> src/engine/io/index_manager/find_leaf.rs:60:21
[INFO] [stdout]    |
[INFO] [stdout] 60 |                     prior_offset = offset;
[INFO] [stdout]    |                     ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stdout]    = help: maybe it is overwritten before being read?
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `a`
[INFO] [stdout]    --> src/engine/objects/types/base_sql_types.rs:117:39
[INFO] [stdout]     |
[INFO] [stdout] 117 |             BaseSqlTypesMapper::Array(a) => todo!("Bed time, need to fix!"),
[INFO] [stdout]     |                                       ^ help: if this is intentional, prefix it with an underscore: `_a`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `tmp_dir`
[INFO] [stdout]   --> src/engine/io/block_layer/lock_manager.rs:71:13
[INFO] [stdout]    |
[INFO] [stdout] 71 |         let tmp_dir = tmp.path().as_os_str().to_os_string();
[INFO] [stdout]    |             ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_tmp_dir`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `tbl_uuid`
[INFO] [stdout]    --> src/engine/io/index_formats/btree_branch.rs:227:13
[INFO] [stdout]     |
[INFO] [stdout] 227 |         let tbl_uuid = Uuid::new_v4();
[INFO] [stdout]     |             ^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_tbl_uuid`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> src/engine/io/page_formats/page_header.rs:111:13
[INFO] [stdout]     |
[INFO] [stdout] 111 |         let mut test = PageHeader::new();
[INFO] [stdout]     |             ----^^^^
[INFO] [stdout]     |             |
[INFO] [stdout]     |             help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `file_manager`
[INFO] [stdout]   --> src/feophant.rs:28:5
[INFO] [stdout]    |
[INFO] [stdout] 28 |     file_manager: Arc<FileManager2>,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `parse_constraint`
[INFO] [stdout]  --> src/engine/objects/constraints/parse_constraint.rs:9:8
[INFO] [stdout]   |
[INFO] [stdout] 9 | pub fn parse_constraint<'a, E: ParseError<&'a str> + ContextError<&'a str>>(
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 13 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 48.56s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/feophantlib-7bd0cc72c52feda8)
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/feophant_server-2bf3f8f2aa4c0f6f)
[INFO] [stderr]   Executable tests/sql_create_table.rs (/opt/rustwide/target/debug/deps/sql_create_table-319a5405cb296b83)
[INFO] [stderr]   Executable tests/sql_garbage.rs (/opt/rustwide/target/debug/deps/sql_garbage-288108d42e32702b)
[INFO] [stderr]   Executable tests/sql_primary_key_insert.rs (/opt/rustwide/target/debug/deps/sql_primary_key_insert-884df98f75420766)
[INFO] [stderr]   Executable tests/sql_simple_insert.rs (/opt/rustwide/target/debug/deps/sql_simple_insert-eeeb5b61535af640)
[INFO] [stderr]   Executable tests/sql_simple_select.rs (/opt/rustwide/target/debug/deps/sql_simple_select-2eca071d4e0bb49f)
[INFO] [stderr]   Executable tests/visibility_tests.rs (/opt/rustwide/target/debug/deps/visibility_tests-1aeaf9da6afeaff3)
[INFO] running `Command { std: "docker" "inspect" "474646b805d2aaf155e8bd1c883fd3d7d6f89c334aef13c33d1b5db17225eeff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "474646b805d2aaf155e8bd1c883fd3d7d6f89c334aef13c33d1b5db17225eeff", kill_on_drop: false }`
[INFO] [stdout] 474646b805d2aaf155e8bd1c883fd3d7d6f89c334aef13c33d1b5db17225eeff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f1ba9709b6f705ffa37ec3170f145cac01319374791828cc936891f1050f3127
[INFO] running `Command { std: "docker" "start" "-a" "f1ba9709b6f705ffa37ec3170f145cac01319374791828cc936891f1050f3127", kill_on_drop: false }`
[INFO] [stderr] warning: unused imports: `BytesMut`, `Bytes`
[INFO] [stderr]   --> src/engine/io/row_formats/item_pointer.rs:11:26
[INFO] [stderr]    |
[INFO] [stderr] 11 | use bytes::{Buf, BufMut, Bytes, BytesMut};
[INFO] [stderr]    |                          ^^^^^  ^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `std::convert::TryFrom`
[INFO] [stderr]   --> src/engine/io/row_formats/item_pointer.rs:12:5
[INFO] [stderr]    |
[INFO] [stderr] 12 | use std::convert::TryFrom;
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `page_offset`
[INFO] [stderr]   --> src/engine/io/index_manager.rs:66:26
[INFO] [stderr]    |
[INFO] [stderr] 66 |         let (page_guard, page_offset, mut leaf) =
[INFO] [stderr]    |                          ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_page_offset`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `o`
[INFO] [stderr]   --> src/engine/io/visible_row_manager.rs:89:20
[INFO] [stderr]    |
[INFO] [stderr] 89 |                 Ok(o) => return Ok(true),
[INFO] [stderr]    |                    ^ help: if this is intentional, prefix it with an underscore: `_o`
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `k`
[INFO] [stderr]    --> src/engine/io/index_formats/btree_leaf.rs:146:25
[INFO] [stderr]     |
[INFO] [stderr] 146 |             .flat_map(|(k, v)| v.clone())
[INFO] [stderr]     |                         ^ help: if this is intentional, prefix it with an underscore: `_k`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `prior_offset` is assigned to, but never used
[INFO] [stderr]   --> src/engine/io/index_manager/find_leaf.rs:33:13
[INFO] [stderr]    |
[INFO] [stderr] 33 |     let mut prior_offset = PageOffset(0);
[INFO] [stderr]    |             ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: consider using `_prior_offset` instead
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `prior_offset` is never read
[INFO] [stderr]   --> src/engine/io/index_manager/find_leaf.rs:60:21
[INFO] [stderr]    |
[INFO] [stderr] 60 |                     prior_offset = offset;
[INFO] [stderr]    |                     ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stderr]    = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `a`
[INFO] [stderr]    --> src/engine/objects/types/base_sql_types.rs:117:39
[INFO] [stderr]     |
[INFO] [stderr] 117 |             BaseSqlTypesMapper::Array(a) => todo!("Bed time, need to fix!"),
[INFO] [stderr]     |                                       ^ help: if this is intentional, prefix it with an underscore: `_a`
[INFO] [stderr] 
[INFO] [stderr] warning: field is never read: `file_manager`
[INFO] [stderr]   --> src/feophant.rs:28:5
[INFO] [stderr]    |
[INFO] [stderr] 28 |     file_manager: Arc<FileManager2>,
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: associated function is never used: `search`
[INFO] [stderr]    --> src/engine/io/index_formats/btree_leaf.rs:140:12
[INFO] [stderr]     |
[INFO] [stderr] 140 |     pub fn search<R>(&self, range: R) -> Vec<ItemPointer>
[INFO] [stderr]     |            ^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `parse_constraint`
[INFO] [stderr]  --> src/engine/objects/constraints/parse_constraint.rs:9:8
[INFO] [stderr]   |
[INFO] [stderr] 9 | pub fn parse_constraint<'a, E: ParseError<&'a str> + ContextError<&'a str>>(
[INFO] [stderr]   |        ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `feophant` (lib) generated 11 warnings
[INFO] [stderr] warning: unused import: `super::*`
[INFO] [stderr]   --> src/engine/io/block_layer/lock_manager.rs:65:9
[INFO] [stderr]    |
[INFO] [stderr] 65 |     use super::*;
[INFO] [stderr]    |         ^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `tmp_dir`
[INFO] [stderr]   --> src/engine/io/block_layer/lock_manager.rs:71:13
[INFO] [stderr]    |
[INFO] [stderr] 71 |         let tmp_dir = tmp.path().as_os_str().to_os_string();
[INFO] [stderr]    |             ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_tmp_dir`
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `tbl_uuid`
[INFO] [stderr]    --> src/engine/io/index_formats/btree_branch.rs:227:13
[INFO] [stderr]     |
[INFO] [stderr] 227 |         let tbl_uuid = Uuid::new_v4();
[INFO] [stderr]     |             ^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_tbl_uuid`
[INFO] [stderr] 
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]    --> src/engine/io/page_formats/page_header.rs:111:13
[INFO] [stderr]     |
[INFO] [stderr] 111 |         let mut test = PageHeader::new();
[INFO] [stderr]     |             ----^^^^
[INFO] [stderr]     |             |
[INFO] [stderr]     |             help: remove this `mut`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_mut)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `feophant` (lib test) generated 13 warnings (9 duplicates)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.58s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/feophantlib-7bd0cc72c52feda8)
[INFO] [stdout] 
[INFO] [stdout] running 101 tests
[INFO] [stdout] test constants::nullable::tests::test_nullable_display ... ok
[INFO] [stdout] test engine::io::block_layer::free_space_manager::tests::test_find_and_fill_pages ... ok
[INFO] [stdout] test constants::nullable::tests::test_nullable_from ... ok
[INFO] [stdout] test engine::io::block_layer::free_space_manager::tests::test_get_and_set ... ok
[INFO] [stdout] test engine::io::index_formats::split_branch::tests::test_simple_split_even ... ok
[INFO] [stdout] test engine::io::block_layer::resource_formatter::tests::test_uuid_formating ... ok
[INFO] [stdout] test codec::pg_codec::tests::test_decode ... ok
[INFO] [stdout] test engine::io::index_formats::split_branch::tests::test_simple_split_odd ... ok
[INFO] [stdout] test engine::io::index_formats::btree_first_page::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::index_formats::btree_branch::tests::test_btree_branch_roundtrip ... ok
[INFO] [stdout] test engine::io::format_traits::serializable::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::index_formats::btree_leaf::tests::sizes_match ... ok
[INFO] [stdout] test engine::io::page_formats::page_header::tests::sizes_match ... ok
[INFO] [stdout] test engine::io::page_formats::page_header::tests::test_initial_freespace ... ok
[INFO] [stdout] test engine::io::page_formats::page_header::tests::test_item_count ... ok
[INFO] [stdout] test engine::io::page_formats::page_header::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::index_formats::index_search::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::page_formats::page_data::tests::test_page_data_update ... ok
[INFO] [stdout] test engine::io::page_formats::item_id_data::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::page_formats::page_header::tests::test_too_big ... ok
[INFO] [stdout] test engine::io::block_layer::file_operations::tests::test_make_sub_path ... ok
[INFO] [stdout] test engine::io::index_formats::btree_leaf::tests::test_btree_leaf_roundtrip ... ok
[INFO] [stdout] test engine::io::page_formats::page_data::tests::test_page_data_roundtrip_two_rows ... ok
[INFO] [stdout] test engine::io::index_formats::btree_leaf::tests::test_btree_leaf_split ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_get_file_chunk_size ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_increment_and_hash_map ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_mul ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_math ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_get_file_number ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_normal ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_fail_usize ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_roundtrip ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_is_same_file ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_add ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_add_assign ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_get_file_seek ... ok
[INFO] [stdout] test engine::io::row_formats::item_pointer::tests::test_item_pointer_error_conditions ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_null_mask_parse ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::sizes_match ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_usize ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_null_mask_serialize ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_uuid_double_opt_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_data_single_text ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_null_mask_single ... ok
[INFO] [stdout] test engine::io::row_formats::item_pointer::tests::test_item_pointer_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::io::page_formats::page_offset::tests::test_calculate_page_offset ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_data_double_text ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_complex_data_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_null_mask_parse_short ... ok
[INFO] [stdout] test engine::io::row_formats::info_mask::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_uuid_double_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::null_mask::tests::test_null_mask_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::item_pointer::tests::sizes_match ... ok
[INFO] [stdout] test engine::io::page_formats::uint12::tests::test_subtraction ... ok
[INFO] [stdout] test engine::io::block_layer::lock_manager::tests::test_locking ... ok
[INFO] [stdout] test engine::io::page_formats::page_data::tests::test_page_data_roundtrip ... ok
[INFO] [stdout] test engine::io::row_formats::item_pointer::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_array_roundtrip ... ok
[INFO] [stdout] test engine::objects::sql_tuple::tests::test_sql_tuple_filter ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::objects::attribute::tests::test_attribute_newfmt ... ok
[INFO] [stdout] test engine::objects::sql_tuple::tests::test_encoded_size ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_integer_roundtrip ... ok
[INFO] [stdout] test engine::objects::sql_tuple::tests::test_sql_tuple_merge ... ok
[INFO] [stdout] test engine::io::utility::tests::test_size_roundtrip ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_builtin_display ... ok
[INFO] [stdout] test engine::objects::sql_tuple::tests::sizes_match ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_exact_encoding ... ok
[INFO] [stdout] test engine::io::row_formats::row_data::tests::test_row_uuid_roundtrip ... ok
[INFO] [stdout] test engine::sql_parser::common::tests::test_parse_sql_string ... ok
[INFO] [stdout] test processor::startup_parser::tests::test_start_up_string ... ok
[INFO] [stdout] test processor::ssl_and_gssapi_parser::tests::test_ssl_match ... ok
[INFO] [stdout] test engine::sql_parser::insert::tests::test_simple_insert ... ok
[INFO] [stdout] test processor::ssl_and_gssapi_parser::tests::test_ssl_not_match ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_long_roundtrip ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_short_roundtrip ... ok
[INFO] [stdout] test engine::objects::types::base_sql_types::tests::test_type_matches ... ok
[INFO] [stdout] test engine::objects::types::parse_type::tests::test_mapping ... ok
[INFO] [stdout] test engine::transactions::transaction_manager::tests::tran_man_statuses ... ok
[INFO] [stdout] test processor::ssl_and_gssapi_parser::tests::test_gsspai_match ... ok
[INFO] [stdout] test engine::sql_parser::select::tests::test_select_parser ... ok
[INFO] [stdout] test processor::startup_parser::tests::test_parse_key_and_values ... ok
[INFO] [stdout] test engine::sql_parser::common::tests::test_sql_identifier ... ok
[INFO] [stdout] test engine::sql_parser::create::create_table::tests::test_nullable_columns ... ok
[INFO] [stdout] test engine::sql_parser::create::create_table::tests::test_simple_table ... ok
[INFO] [stdout] test processor::startup_parser::tests::test_till_null ... ok
[INFO] [stdout] test engine::analyzer::definition_lookup::tests::test_no_such_class ... ok
[INFO] [stdout] test processor::startup_parser::tests::test_invalid_utf8_till_null - should panic ... ok
[INFO] [stdout] 02:54:50 [DEBUG] (5) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(bb18fe14-4dd2-45ea-8c1e-30db5ccc6289)), Some(Text("foo"))])
[INFO] [stdout] 02:54:50 [DEBUG] (5) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] test engine::io::index_formats::btree_first_page::tests::test_on_disk ... ok
[INFO] [stdout] test engine::io::index_manager::split_leaf::tests::test_split_leaf ... ok
[INFO] [stdout] test engine::io::index_manager::find_leaf::tests::test_find ... ok
[INFO] [stdout] 02:54:50 [DEBUG] (155) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(0986591d-a0f7-4c54-aea8-047e58e46997)), Some(Text("foo"))])
[INFO] [stdout] 02:54:50 [DEBUG] (155) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] 02:54:50 [DEBUG] (5) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(bb18fe14-4dd2-45ea-8c1e-30db5ccc6289)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(true))])
[INFO] [stdout] 02:54:50 [DEBUG] (5) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] test engine::analyzer::definition_lookup::tests::test_find_pg_class ... ok
[INFO] [stdout] test engine::io::block_layer::file_manager2::tests::test_roundtrips ... ok
[INFO] [stdout] test engine::io::row_manager::tests::test_row_manager_crud ... ok
[INFO] [stdout] test engine::io::block_layer::free_space_manager::tests::test_get_next ... ok
[INFO] [stdout] test engine::analyzer::definition_lookup::tests::test_def_lookup ... ok
[INFO] [stdout] 02:54:50 [DEBUG] (155) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(0986591d-a0f7-4c54-aea8-047e58e46997)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(true))])
[INFO] [stdout] 02:54:50 [DEBUG] (155) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] test engine::tests::create_insert_select ... ok
[INFO] [stdout] test engine::io::row_manager::tests::test_row_manager_mass_insert ... ok
[INFO] [stdout] 02:54:56 [DEBUG] (41) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("test")), Some(Integer(999))])
[INFO] [stdout] test engine::io::index_manager::tests::test_roundtrip ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 101 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.58s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/feophant_server-2bf3f8f2aa4c0f6f)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sql_create_table.rs (/opt/rustwide/target/debug/deps/sql_create_table-319a5405cb296b83)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::feophant: Bound to port 45839, but not processing yet.
[INFO] [stdout] 02:54:56 [INFO] Up and listening on port 45839
[INFO] [stdout] 02:54:56 [INFO] Got a connection from 127.0.0.1:38314
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"\0\0\0,\0\x03\0\0client_encoding\0UTF8\0user\0postgres\0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 0 and payload [0, 3, 0, 0, 99, 108, 105, 101, 110, 116, 95, 101, 110, 99, 111, 100, 105, 110, 103, 0, 85, 84, 70, 56, 0, 117, 115, 101, 114, 0, 112, 111, 115, 116, 103, 114, 101, 115, 0, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::processor::client_processor: Got a startup message!
[INFO] [stdout] 02:54:56 [INFO] Just going to let Some("postgres") in
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 52 and payload b"\0\0\0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:56 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: create table foo (
[INFO] [stdout]             bar text primary key, 
[INFO] [stdout]             baz text not null, 
[INFO] [stdout]             another text null
[INFO] [stdout]         )
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0\x82create table foo (\n            bar text primary key, \n            baz text not null, \n            another text null\n        )\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 114, 32, 116, 101, 120, 116, 32, 112, 114, 105, 109, 97, 114, 121, 32, 107, 101, 121, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 10, 32, 32, 32, 32, 32, 32, 32, 32, 41, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::processor::client_processor: Got query [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 114, 32, 116, 101, 120, 116, 32, 112, 114, 105, 109, 97, 114, 121, 32, 107, 101, 121, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 10, 32, 32, 32, 32, 32, 32, 32, 32, 41, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Text("foo"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(true))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Text("baz")), Some(Text("text")), Some(Integer(1)), Some(Bool(false))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("baz"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Text("another")), Some(Text("text")), Some(Integer(2)), Some(Bool(true))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("another"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(60f5e8db-e7dd-42e7-ad03-42e8023126f2)), Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Text("foo_primary_key_index")), Some(Array([Integer(0)])), Some(Bool(true))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo_primary_key_index"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(09329944-2790-47be-8833-d80e16285e48)), Some(Uuid(d6b2cbe7-4173-46d1-a51f-0c17095c7355)), Some(Uuid(60f5e8db-e7dd-42e7-ad03-42e8023126f2)), Some(Text("foo_primary_key")), Some(Text("PrimaryKey"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo_primary_key"))])
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:56 [INFO] Got shutdown request
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::feophant: Attempting to signal shutdown.
[INFO] [stdout] test create_table_with_nullable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.30s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sql_garbage.rs (/opt/rustwide/target/debug/deps/sql_garbage-288108d42e32702b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::feophant: Bound to port 43527, but not processing yet.
[INFO] [stdout] 02:54:56 [INFO] Up and listening on port 43527
[INFO] [stdout] 02:54:56 [INFO] Got a connection from 127.0.0.1:52368
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"\0\0\0,\0\x03\0\0client_encoding\0UTF8\0user\0postgres\0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 0 and payload [0, 3, 0, 0, 99, 108, 105, 101, 110, 116, 95, 101, 110, 99, 111, 100, 105, 110, 103, 0, 85, 84, 70, 56, 0, 117, 115, 101, 114, 0, 112, 111, 115, 116, 103, 114, 101, 115, 0, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::processor::client_processor: Got a startup message!
[INFO] [stdout] 02:54:56 [INFO] Just going to let Some("postgres") in
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 52 and payload b"\0\0\0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:56 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: Lorem ipsum dolor sit amet
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0\x1fLorem ipsum dolor sit amet\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [76, 111, 114, 101, 109, 32, 105, 112, 115, 117, 109, 32, 100, 111, 108, 111, 114, 32, 115, 105, 116, 32, 97, 109, 101, 116, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::processor::client_processor: Got query [76, 111, 114, 101, 109, 32, 105, 112, 115, 117, 109, 32, 100, 111, 108, 111, 114, 32, 115, 105, 116, 32, 97, 109, 101, 116, 0]
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 45 and payload b"SERROR\0MSQL Parse Error 0: at line 1, in Tag:\nLorem ipsum dolor sit amet\0\n^\n\n1: at line 1, in Alt:\nLorem ipsum dolor sit amet\0\n^\n\n\0C58000\0\0"
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:56 [INFO] Got shutdown request
[INFO] [stdout] 02:54:56 [DEBUG] (2) feophantlib::feophant: Attempting to signal shutdown.
[INFO] [stdout] test garbage ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sql_primary_key_insert.rs (/opt/rustwide/target/debug/deps/sql_primary_key_insert-884df98f75420766)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Bound to port 45781, but not processing yet.
[INFO] [stdout] 02:54:57 [INFO] Up and listening on port 45781
[INFO] [stdout] 02:54:57 [INFO] Got a connection from 127.0.0.1:53266
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"\0\0\0,\0\x03\0\0client_encoding\0UTF8\0user\0postgres\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 0 and payload [0, 3, 0, 0, 99, 108, 105, 101, 110, 116, 95, 101, 110, 99, 111, 100, 105, 110, 103, 0, 85, 84, 70, 56, 0, 117, 115, 101, 114, 0, 112, 111, 115, 116, 103, 114, 101, 115, 0, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got a startup message!
[INFO] [stdout] 02:54:57 [INFO] Just going to let Some("postgres") in
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 52 and payload b"\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: create table foo (
[INFO] [stdout]             bar text not null primary key, 
[INFO] [stdout]             baz text not null, 
[INFO] [stdout]             another text null)
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0\x82create table foo (\n            bar text not null primary key, \n            baz text not null, \n            another text null)\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 114, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 32, 112, 114, 105, 109, 97, 114, 121, 32, 107, 101, 121, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 114, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 32, 112, 114, 105, 109, 97, 114, 121, 32, 107, 101, 121, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 10, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(false))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Text("baz")), Some(Text("text")), Some(Integer(1)), Some(Bool(false))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("baz"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Text("another")), Some(Text("text")), Some(Integer(2)), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("another"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(710d9796-6eee-459c-b62d-4fecc2b6e40a)), Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Text("foo_primary_key_index")), Some(Array([Integer(0)])), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo_primary_key_index"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(27ea8bc0-2e58-40ec-8474-af01ab4963db)), Some(Uuid(d36586fb-1fa6-47f5-b20a-5bdac4976bfb)), Some(Uuid(710d9796-6eee-459c-b62d-4fecc2b6e40a)), Some(Text("foo_primary_key")), Some(Text("PrimaryKey"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo_primary_key"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: insert into foo (bar, baz, another) values('one', 'two', 'three')
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Finsert into foo (bar, baz, another) values('one', 'two', 'three')\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 39, 111, 110, 101, 39, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 39, 111, 110, 101, 39, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Text("one")), Some(Text("two")), Some(Text("three"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("one"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 54 and payload b"\0\x03bar\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0baz\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0another\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 44 and payload b"\0\x03\0\0\0\x03one\0\0\0\x03two\0\0\0\x05three"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 1\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing simple query: select bar, baz, another from foo;
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0'select bar, baz, another from foo;\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [115, 101, 108, 101, 99, 116, 32, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 102, 114, 111, 109, 32, 102, 111, 111, 59, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [115, 101, 108, 101, 99, 116, 32, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 102, 114, 111, 109, 32, 102, 111, 111, 59, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 54 and payload b"\0\x03bar\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0baz\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0another\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 44 and payload b"\0\x03\0\0\0\x03one\0\0\0\x03two\0\0\0\x05three"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 1\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: insert into foo (bar, baz, another) values('one', 'two', 'three')
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Finsert into foo (bar, baz, another) values('one', 'two', 'three')\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 39, 111, 110, 101, 39, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 98, 97, 114, 44, 32, 98, 97, 122, 44, 32, 97, 110, 111, 116, 104, 101, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 39, 111, 110, 101, 39, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Text("one")), Some(Text("two")), Some(Text("three"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("one"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 45 and payload b"SERROR\0MPrimary Key violation\0C58000\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [INFO] Got shutdown request
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Attempting to signal shutdown.
[INFO] [stdout] test primary_key_insert ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.22s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sql_simple_insert.rs (/opt/rustwide/target/debug/deps/sql_simple_insert-eeeb5b61535af640)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Bound to port 46573, but not processing yet.
[INFO] [stdout] 02:54:57 [INFO] Up and listening on port 46573
[INFO] [stdout] 02:54:57 [INFO] Got a connection from 127.0.0.1:46360
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"\0\0\0,\0\x03\0\0client_encoding\0UTF8\0user\0postgres\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 0 and payload [0, 3, 0, 0, 99, 108, 105, 101, 110, 116, 95, 101, 110, 99, 111, 100, 105, 110, 103, 0, 85, 84, 70, 56, 0, 117, 115, 101, 114, 0, 112, 111, 115, 116, 103, 114, 101, 115, 0, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got a startup message!
[INFO] [stdout] 02:54:57 [INFO] Just going to let Some("postgres") in
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 52 and payload b"\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: create table foo (bar text, baz text not null, another text null)
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Fcreate table foo (bar text, baz text not null, another text null)\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 98, 97, 114, 32, 116, 101, 120, 116, 44, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 98, 97, 114, 32, 116, 101, 120, 116, 44, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(6f774a44-a083-4aab-b545-70d3a148827e)), Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(6f774a44-a083-4aab-b545-70d3a148827e)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(6f774a44-a083-4aab-b545-70d3a148827e)), Some(Text("baz")), Some(Text("text")), Some(Integer(1)), Some(Bool(false))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("baz"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(6f774a44-a083-4aab-b545-70d3a148827e)), Some(Text("another")), Some(Text("text")), Some(Integer(2)), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("another"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: insert into foo (another, baz, bar) values(null, 'two', 'three')
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Einsert into foo (another, baz, bar) values(null, 'two', 'three')\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 97, 110, 111, 116, 104, 101, 114, 44, 32, 98, 97, 122, 44, 32, 98, 97, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 110, 117, 108, 108, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 97, 110, 111, 116, 104, 101, 114, 44, 32, 98, 97, 122, 44, 32, 98, 97, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 110, 117, 108, 108, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 54 and payload b"\0\x03bar\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0baz\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0another\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 44 and payload b"\0\x03\0\0\0\x05three\0\0\0\x03two\xff\xff\xff\xff"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 1\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [INFO] Got shutdown request
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Attempting to signal shutdown.
[INFO] [stdout] test simple_insert ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.45s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sql_simple_select.rs (/opt/rustwide/target/debug/deps/sql_simple_select-2eca071d4e0bb49f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Bound to port 45361, but not processing yet.
[INFO] [stdout] 02:54:57 [INFO] Up and listening on port 45361
[INFO] [stdout] 02:54:57 [INFO] Got a connection from 127.0.0.1:40902
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"\0\0\0,\0\x03\0\0client_encoding\0UTF8\0user\0postgres\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 0 and payload [0, 3, 0, 0, 99, 108, 105, 101, 110, 116, 95, 101, 110, 99, 111, 100, 105, 110, 103, 0, 85, 84, 70, 56, 0, 117, 115, 101, 114, 0, 112, 111, 115, 116, 103, 114, 101, 115, 0, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got a startup message!
[INFO] [stdout] 02:54:57 [INFO] Just going to let Some("postgres") in
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 52 and payload b"\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: create table foo (bar text, baz text not null, another text null)
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Fcreate table foo (bar text, baz text not null, another text null)\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 98, 97, 114, 32, 116, 101, 120, 116, 44, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [99, 114, 101, 97, 116, 101, 32, 116, 97, 98, 108, 101, 32, 102, 111, 111, 32, 40, 98, 97, 114, 32, 116, 101, 120, 116, 44, 32, 98, 97, 122, 32, 116, 101, 120, 116, 32, 110, 111, 116, 32, 110, 117, 108, 108, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 116, 101, 120, 116, 32, 110, 117, 108, 108, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(a944ed2f-761b-435e-9d1a-b11fe1062e3e)), Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("foo"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(a944ed2f-761b-435e-9d1a-b11fe1062e3e)), Some(Text("bar")), Some(Text("text")), Some(Integer(0)), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("bar"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(a944ed2f-761b-435e-9d1a-b11fe1062e3e)), Some(Text("baz")), Some(Text("text")), Some(Integer(1)), Some(Bool(false))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("baz"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::constraint_manager: searching for SqlTuple([Some(Uuid(a944ed2f-761b-435e-9d1a-b11fe1062e3e)), Some(Text("another")), Some(Text("text")), Some(Integer(2)), Some(Bool(true))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::engine::io::index_manager: index searching for SqlTuple([Some(Text("another"))])
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing statement batch: insert into foo (another, baz, bar) values(null, 'two', 'three')
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0Einsert into foo (another, baz, bar) values(null, 'two', 'three')\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 97, 110, 111, 116, 104, 101, 114, 44, 32, 98, 97, 122, 44, 32, 98, 97, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 110, 117, 108, 108, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [105, 110, 115, 101, 114, 116, 32, 105, 110, 116, 111, 32, 102, 111, 111, 32, 40, 97, 110, 111, 116, 104, 101, 114, 44, 32, 98, 97, 122, 44, 32, 98, 97, 114, 41, 32, 118, 97, 108, 117, 101, 115, 40, 110, 117, 108, 108, 44, 32, 39, 116, 119, 111, 39, 44, 32, 39, 116, 104, 114, 101, 101, 39, 41, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 54 and payload b"\0\x03bar\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0baz\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0another\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 44 and payload b"\0\x03\0\0\0\x05three\0\0\0\x03two\xff\xff\xff\xff"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 1\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [DEBUG] (2) tokio_postgres::simple_query: executing simple query: select baz, bar, another from foo;
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message b"Q\0\0\0'select baz, bar, another from foo;\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Got message type 51 and payload [115, 101, 108, 101, 99, 116, 32, 98, 97, 122, 44, 32, 98, 97, 114, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 102, 114, 111, 109, 32, 102, 111, 111, 59, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::processor::client_processor: Got query [115, 101, 108, 101, 99, 116, 32, 98, 97, 122, 44, 32, 98, 97, 114, 44, 32, 97, 110, 111, 116, 104, 101, 114, 32, 102, 114, 111, 109, 32, 102, 111, 111, 59, 0]
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 54 and payload b"\0\x03baz\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0bar\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0another\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 44 and payload b"\0\x03\0\0\0\x03two\0\0\0\x05three\xff\xff\xff\xff"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 43 and payload b"SELECT 1\0"
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::codec::pg_codec: Sending message type 5a and payload b"I"
[INFO] [stdout] 02:54:57 [INFO] Got shutdown request
[INFO] [stdout] 02:54:57 [DEBUG] (2) feophantlib::feophant: Attempting to signal shutdown.
[INFO] [stdout] test simple_select ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/visibility_tests.rs (/opt/rustwide/target/debug/deps/visibility_tests-1aeaf9da6afeaff3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_row_manager_visibility ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests feophantlib
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/engine/io/page_formats/page_offset.rs - engine::io::page_formats::page_offset::PageOffset::get_bitmask_offset (line 47) ... ok
[INFO] [stdout] test src/engine/io/row_formats/null_mask.rs - engine::io::row_formats::null_mask::NullMask::serialize (line 13) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.30s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f1ba9709b6f705ffa37ec3170f145cac01319374791828cc936891f1050f3127", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f1ba9709b6f705ffa37ec3170f145cac01319374791828cc936891f1050f3127", kill_on_drop: false }`
[INFO] [stdout] f1ba9709b6f705ffa37ec3170f145cac01319374791828cc936891f1050f3127