[INFO] cloning repository https://github.com/photoszzt/cache_server
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/photoszzt/cache_server" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphotoszzt%2Fcache_server", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphotoszzt%2Fcache_server'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 522a2fc3fcb8ba57fd7e24a7505b41cd60a0321e
[INFO] testing photoszzt/cache_server against beta-2024-12-08 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphotoszzt%2Fcache_server" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/photoszzt/cache_server on toolchain beta-2024-12-08
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/photoszzt/cache_server
[INFO] finished tweaking git repo https://github.com/photoszzt/cache_server
[INFO] tweaked toml for git repo https://github.com/photoszzt/cache_server written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/photoszzt/cache_server already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 912f415d2f979dd8289a6f7b0de0c2a42d9bf48626a07df9c01e397fcdf78986
[INFO] running `Command { std: "docker" "start" "-a" "912f415d2f979dd8289a6f7b0de0c2a42d9bf48626a07df9c01e397fcdf78986", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "912f415d2f979dd8289a6f7b0de0c2a42d9bf48626a07df9c01e397fcdf78986", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "912f415d2f979dd8289a6f7b0de0c2a42d9bf48626a07df9c01e397fcdf78986", kill_on_drop: false }`
[INFO] [stdout] 912f415d2f979dd8289a6f7b0de0c2a42d9bf48626a07df9c01e397fcdf78986
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 05db6e62a9b03bac374b4e3c1af808e433d140f5657440bbb0b3250b5a3fd443
[INFO] running `Command { std: "docker" "start" "-a" "05db6e62a9b03bac374b4e3c1af808e433d140f5657440bbb0b3250b5a3fd443", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.78
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling syn v1.0.42
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling log v0.4.11
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling getrandom v0.1.15
[INFO] [stderr]    Compiling pin-project-lite v0.1.10
[INFO] [stderr]    Compiling byteorder v1.3.4
[INFO] [stderr]    Compiling serde v1.0.116
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling proc-macro-hack v0.5.18
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling slab v0.4.2
[INFO] [stderr]    Compiling tracing-core v0.1.17
[INFO] [stderr]    Compiling pin-project-internal v0.4.25
[INFO] [stderr]    Compiling arc-swap v0.4.7
[INFO] [stderr]    Compiling num-traits v0.2.12
[INFO] [stderr]    Compiling num-integer v0.1.43
[INFO] [stderr]    Compiling indexmap v1.6.0
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling serde_json v1.0.58
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling bytes v0.5.6
[INFO] [stderr]    Compiling futures-core v0.3.5
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling textwrap v0.12.1
[INFO] [stderr]    Compiling tracing-log v0.1.1
[INFO] [stderr]    Compiling sharded-slab v0.0.9
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling futures-sink v0.3.6
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling os_str_bytes v2.3.2
[INFO] [stderr]    Compiling net2 v0.2.35
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling signal-hook-registry v1.2.1
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling const-random-macro v0.1.8
[INFO] [stderr]    Compiling smallvec v1.4.2
[INFO] [stderr]    Compiling termcolor v1.1.0
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling mio v0.6.22
[INFO] [stderr]    Compiling regex-automata v0.1.9
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling const-random v0.1.8
[INFO] [stderr]    Compiling ahash v0.3.8
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling linked-hash-map v0.5.3
[INFO] [stderr]    Compiling dashmap v3.11.10
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling mio-uds v0.6.8
[INFO] [stderr]    Compiling matchers v0.0.1
[INFO] [stderr]    Compiling tracing-serde v0.1.2
[INFO] [stderr]    Compiling tracing-attributes v0.1.11
[INFO] [stderr]    Compiling tokio-macros v0.2.5
[INFO] [stderr]    Compiling clap_derive v3.0.0-beta.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.21
[INFO] [stderr]    Compiling tokio v0.2.22
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling tracing v0.1.21
[INFO] [stderr]    Compiling pin-project v0.4.25
[INFO] [stderr]    Compiling tracing-subscriber v0.2.13
[INFO] [stderr]    Compiling tracing-futures v0.2.4
[INFO] [stderr]    Compiling clap v3.0.0-beta.2
[INFO] [stderr]    Compiling tokio-util v0.3.1
[INFO] [stderr]    Compiling lrucache v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:154:7
[INFO] [stdout]     |
[INFO] [stdout] 154 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout]     = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:178:7
[INFO] [stdout]     |
[INFO] [stdout] 178 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 39.26s
[INFO] running `Command { std: "docker" "inspect" "05db6e62a9b03bac374b4e3c1af808e433d140f5657440bbb0b3250b5a3fd443", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05db6e62a9b03bac374b4e3c1af808e433d140f5657440bbb0b3250b5a3fd443", kill_on_drop: false }`
[INFO] [stdout] 05db6e62a9b03bac374b4e3c1af808e433d140f5657440bbb0b3250b5a3fd443
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a24bec36dee472aca7260b2d106941c9aeb34f4164c9a9ea8084869ff1877cc8
[INFO] running `Command { std: "docker" "start" "-a" "a24bec36dee472aca7260b2d106941c9aeb34f4164c9a9ea8084869ff1877cc8", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.1.15
[INFO] [stderr]    Compiling ppv-lite86 v0.2.9
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling const-random-macro v0.1.8
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling const-random v0.1.8
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling ahash v0.3.8
[INFO] [stderr]    Compiling dashmap v3.11.10
[INFO] [stderr]    Compiling lrucache v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:154:7
[INFO] [stdout]     |
[INFO] [stdout] 154 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout]     = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:178:7
[INFO] [stdout]     |
[INFO] [stdout] 178 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:154:7
[INFO] [stdout]     |
[INFO] [stdout] 154 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout]     = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:178:7
[INFO] [stdout]     |
[INFO] [stdout] 178 | #[cfg(feature = "heapsize")]
[INFO] [stdout]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stdout]    --> src/lrucache.rs:921:11
[INFO] [stdout]     |
[INFO] [stdout] 921 |     #[cfg(feature = "heapsize")]
[INFO] [stdout]     |           ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stdout]     |
[INFO] [stdout]     = note: no expected values for `feature`
[INFO] [stdout]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stdout]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.86s
[INFO] running `Command { std: "docker" "inspect" "a24bec36dee472aca7260b2d106941c9aeb34f4164c9a9ea8084869ff1877cc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a24bec36dee472aca7260b2d106941c9aeb34f4164c9a9ea8084869ff1877cc8", kill_on_drop: false }`
[INFO] [stdout] a24bec36dee472aca7260b2d106941c9aeb34f4164c9a9ea8084869ff1877cc8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 13b41a57a850e4dd9b1bb395ce9114e3ce96e138d9a9efa8ac45689a3d9423e1
[INFO] running `Command { std: "docker" "start" "-a" "13b41a57a850e4dd9b1bb395ce9114e3ce96e138d9a9efa8ac45689a3d9423e1", kill_on_drop: false }`
[INFO] [stderr] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stderr]    --> src/lrucache.rs:154:7
[INFO] [stderr]     |
[INFO] [stderr] 154 | #[cfg(feature = "heapsize")]
[INFO] [stderr]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stderr]     |
[INFO] [stderr]     = note: no expected values for `feature`
[INFO] [stderr]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stderr]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stderr]     = note: `#[warn(unexpected_cfgs)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stderr]    --> src/lrucache.rs:178:7
[INFO] [stderr]     |
[INFO] [stderr] 178 | #[cfg(feature = "heapsize")]
[INFO] [stderr]     |       ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stderr]     |
[INFO] [stderr]     = note: no expected values for `feature`
[INFO] [stderr]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stderr]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stderr] 
[INFO] [stderr] warning: `lrucache` (lib) generated 2 warnings
[INFO] [stderr] warning: unexpected `cfg` condition value: `heapsize`
[INFO] [stderr]    --> src/lrucache.rs:921:11
[INFO] [stderr]     |
[INFO] [stderr] 921 |     #[cfg(feature = "heapsize")]
[INFO] [stderr]     |           ^^^^^^^^^^^^^^^^^^^^ help: remove the condition
[INFO] [stderr]     |
[INFO] [stderr]     = note: no expected values for `feature`
[INFO] [stderr]     = help: consider adding `heapsize` as a feature in `Cargo.toml`
[INFO] [stderr]     = note: see <https://doc.rust-lang.org/nightly/rustc/check-cfg/cargo-specifics.html> for more information about checking conditional configuration
[INFO] [stderr] 
[INFO] [stderr] warning: `lrucache` (lib test) generated 3 warnings (2 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lrucache-f667efd5ebc4a18e)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test frame::resp_parser_tests::test_bulk_string ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_int ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_array ... ok
[INFO] [stdout] test lrucache::tests::test_change_capacity ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_simple_string ... ok
[INFO] [stdout] test lrucache::tests::test_clear ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_error ... ok
[INFO] [stdout] test lrucache::tests::test_debug ... ok
[INFO] [stdout] test lrucache::tests::test_contains_key ... ok
[INFO] [stdout] test lrucache::tests::test_remove ... ok
[INFO] [stdout] test lrucache::tests::test_expire_lru ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_reinsert_larger ... ok
[INFO] [stdout] test lrucache::tests::test_pop ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache ... ok
[INFO] [stdout] test lrucache::tests::test_iter ... ok
[INFO] [stdout] test lrucache::tests::test_put_and_get ... ok
[INFO] [stdout] test lrucache::tests::test_put_update ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_oversize ... ok
[INFO] [stdout] test cache::tests::test_remove ... ok
[INFO] [stdout] test cache::tests::test_meta_srem ... ok
[INFO] [stdout] test cache::tests::test_get_insert ... ok
[INFO] [stdout] test cache::tests::test_meta_sadd_duplicate ... ok
[INFO] [stdout] test cache::tests::test_meta_sadd ... ok
[INFO] [stdout] test cache::tests::test_ttl ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.30s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/server.rs (/opt/rustwide/target/debug/deps/cache_server-2e1cbb4b3d966ad8)
[INFO] [stdout] 
[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] [stderr]      Running tests/server.rs (/opt/rustwide/target/debug/deps/server-d10a7f442b9d942b)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test key_value_get_set ... FAILED
[INFO] [stdout] test key_value_timeout ... FAILED
[INFO] [stdout] test manage_subscription ... FAILED
[INFO] [stdout] test pub_sub ... FAILED
[INFO] [stdout] test send_error_get_set_after_subscribe ... FAILED
[INFO] [stdout] test send_error_unknown_command ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- key_value_get_set stdout ----
[INFO] [stdout] thread 'key_value_get_set' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c4b0ad - server::key_value_get_set::{{closure}}::he47e3cfc22e1323a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:14:31
[INFO] [stdout]   22:     0x5b9474c1315f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h07580ff26bae1bda
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c26df3 - tokio::coop::with_budget::{{closure}}::h99530c9df30f8f8d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c3ac0a - std::thread::local::LocalKey<T>::try_with::hf26baa39bfccf24e
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c37e9a - std::thread::local::LocalKey<T>::with::h2b3a602466f3626f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c12c5f - tokio::coop::with_budget::h019e8388ab9a7f78
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c12c5f - tokio::coop::budget::hba7570bbe9e6db4f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c12c5f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hdbe3edd2e0a37a04
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14dee - tokio::runtime::basic_scheduler::enter::{{closure}}::h0f282ddcddf10bbd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b3c7 - tokio::macros::scoped_tls::ScopedKey<T>::set::h7baffc12c53ccba5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c13e8e - tokio::runtime::basic_scheduler::enter::h280b73e1ca584561
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c10480 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::hd7f1dd2973dde246
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a505 - tokio::runtime::Runtime::block_on::{{closure}}::h81350f740ee87e35
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3be54 - tokio::runtime::context::enter::hcd75761fecf3699a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfe15c - tokio::runtime::handle::Handle::enter::hc23eb78c19ad8bb3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a0c7 - tokio::runtime::Runtime::block_on::h2ecdcfbf27b90864
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c4adea - server::key_value_get_set::h0c11a01b2bdb7147
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:12:1
[INFO] [stdout]   38:     0x5b9474c4ac57 - server::key_value_get_set::{{closure}}::h37e04114a5c58825
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:13:29
[INFO] [stdout]   39:     0x5b9474beb396 - core::ops::function::FnOnce::call_once::hb449a903f8091338
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- key_value_timeout stdout ----
[INFO] [stdout] thread 'key_value_timeout' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c4c978 - server::key_value_timeout::{{closure}}::h149d154d7b80f39c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:71:31
[INFO] [stdout]   22:     0x5b9474c136ef - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h9e00d2a56b6544d7
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c26343 - tokio::coop::with_budget::{{closure}}::h23c2b6abd9c5d51d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c38afa - std::thread::local::LocalKey<T>::try_with::h133b5e0c463ddf03
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c383fa - std::thread::local::LocalKey<T>::with::hce56d63bf43147e2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c11d7f - tokio::coop::with_budget::h55a0e7cd88cda98f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c11d7f - tokio::coop::budget::h724a4a93016821b4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c11d7f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hcc0214c75c350a58
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14f2e - tokio::runtime::basic_scheduler::enter::{{closure}}::hc893446a7c5009b2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b727 - tokio::macros::scoped_tls::ScopedKey<T>::set::hd580d2f0f47106fc
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c14d4e - tokio::runtime::basic_scheduler::enter::hf62ac916fdf0246e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c10380 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h599b73637dcd8570
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a895 - tokio::runtime::Runtime::block_on::{{closure}}::hde801c76f0a8cc5d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3bf64 - tokio::runtime::context::enter::hfdca400c16ec73ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfe2dc - tokio::runtime::handle::Handle::enter::heac61715a1147b44
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a1c7 - tokio::runtime::Runtime::block_on::h6630e64016bb69b3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c4c6aa - server::key_value_timeout::hfec6ac5b6473dc86
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:67:1
[INFO] [stdout]   38:     0x5b9474c4c517 - server::key_value_timeout::{{closure}}::hcdaced37a7d26bd3
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:68:29
[INFO] [stdout]   39:     0x5b9474beb356 - core::ops::function::FnOnce::call_once::hb05feb598e967497
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- manage_subscription stdout ----
[INFO] [stdout] thread 'manage_subscription' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c51f92 - server::manage_subscription::{{closure}}::h1b122b2c7e5c99e2
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:247:31
[INFO] [stdout]   22:     0x5b9474c1374f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hd394292b93dfbdba
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c26933 - tokio::coop::with_budget::{{closure}}::h5b1df2a4a0eb0a9a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c3a44a - std::thread::local::LocalKey<T>::try_with::hbc3fbf1e8fdbc1ec
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c381ca - std::thread::local::LocalKey<T>::with::h949fbf87d396d241
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c124ef - tokio::coop::with_budget::h65cdf30b31b1e8cc
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c124ef - tokio::coop::budget::h39df0346aeaa6a7b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c124ef - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hcc222de7d2dee173
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14ede - tokio::runtime::basic_scheduler::enter::{{closure}}::hc61b12a7b4a7689c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b187 - tokio::macros::scoped_tls::ScopedKey<T>::set::h39a075d19a497bff
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c13ade - tokio::runtime::basic_scheduler::enter::h1958a80f8a6d4ef9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c10340 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h2e8050969c198db0
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a3d5 - tokio::runtime::Runtime::block_on::{{closure}}::h73a72d916e3ff1fd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3ba14 - tokio::runtime::context::enter::h56598e0b4b4a82b4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfdfdc - tokio::runtime::handle::Handle::enter::h221f7bfec76b92f1
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a017 - tokio::runtime::Runtime::block_on::h0b8c5cddf6dfadaa
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c51c0a - server::manage_subscription::h8ea9186be603555f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:245:1
[INFO] [stdout]   38:     0x5b9474c51a77 - server::manage_subscription::{{closure}}::h3e81b79a70e82bb6
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:246:31
[INFO] [stdout]   39:     0x5b9474beb2d6 - core::ops::function::FnOnce::call_once::h850287317f83cd33
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- pub_sub stdout ----
[INFO] [stdout] thread 'pub_sub' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stderr] error: test failed, to rerun pass `--test server`
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c4e0eb - server::pub_sub::{{closure}}::hb9a31cd9e339320e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:124:31
[INFO] [stdout]   22:     0x5b9474c132ff - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h2d9ccec2f148c627
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c273e3 - tokio::coop::with_budget::{{closure}}::hc6b4c9be0f0aa769
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c3a33a - std::thread::local::LocalKey<T>::try_with::ha64cf512a4c2f8c1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c37fba - std::thread::local::LocalKey<T>::with::h45f81d0afb55facf
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c1160f - tokio::coop::with_budget::hf20d955ea3e6eb17
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c1160f - tokio::coop::budget::h495282936560fd7b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c1160f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::ha8c886418b856272
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14e3c - tokio::runtime::basic_scheduler::enter::{{closure}}::h97945f60eb8e7ab1
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b609 - tokio::macros::scoped_tls::ScopedKey<T>::set::hb6636a1918e7c330
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c145ee - tokio::runtime::basic_scheduler::enter::h8f4e9beabe392820
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c103c2 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h676c65f324b74d9d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a635 - tokio::runtime::Runtime::block_on::{{closure}}::h9ac20df164f734a8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3bc34 - tokio::runtime::context::enter::hc8c67fd83aad5b5a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfdf1a - tokio::runtime::handle::Handle::enter::h0b2ad340aee9f22c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a069 - tokio::runtime::Runtime::block_on::h2da80f5396612ed4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c4dd08 - server::pub_sub::h521c737ca0a0768c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:122:1
[INFO] [stdout]   38:     0x5b9474c4db77 - server::pub_sub::{{closure}}::hdcb2e1fdfe5911b0
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:123:19
[INFO] [stdout]   39:     0x5b9474beb436 - core::ops::function::FnOnce::call_once::hbbd3916bb8de2f8e
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- send_error_get_set_after_subscribe stdout ----
[INFO] [stdout] thread 'send_error_get_set_after_subscribe' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c55948 - server::send_error_get_set_after_subscribe::{{closure}}::hb8aa4edcb1994bd7
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:360:31
[INFO] [stdout]   22:     0x5b9474c1365f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h7afcac3c798c867e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c272b3 - tokio::coop::with_budget::{{closure}}::hbed0debbd90d3953
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c39cfa - std::thread::local::LocalKey<T>::try_with::h82a136344d250c13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c3835a - std::thread::local::LocalKey<T>::with::hbd15849d5fdd85a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c10e9f - tokio::coop::with_budget::hf910dfd177b25d8a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c10e9f - tokio::coop::budget::hdd84dc9d81de8ea0
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c10e9f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h4b3162d01f698a7d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14f7c - tokio::runtime::basic_scheduler::enter::{{closure}}::he65de24c699520b2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b2a9 - tokio::macros::scoped_tls::ScopedKey<T>::set::h542519b2c32c7cbb
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c1499e - tokio::runtime::basic_scheduler::enter::hdcfc7503b060816f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c10402 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h6bad8de601eeb15b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a2a5 - tokio::runtime::Runtime::block_on::{{closure}}::h538bf3e8291a0c61
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3bd44 - tokio::runtime::context::enter::hc9b2bc6621d67b83
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfe21a - tokio::runtime::handle::Handle::enter::hc5c0d0d194d555e5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a119 - tokio::runtime::Runtime::block_on::h44eea4a7a76598cf
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c556a8 - server::send_error_get_set_after_subscribe::hd4da45646430d36c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:358:1
[INFO] [stdout]   38:     0x5b9474c55517 - server::send_error_get_set_after_subscribe::{{closure}}::h00d80fc946f5adc8
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:359:46
[INFO] [stdout]   39:     0x5b9474beb666 - core::ops::function::FnOnce::call_once::hf0a545b0505e53b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- send_error_unknown_command stdout ----
[INFO] [stdout] thread 'send_error_unknown_command' panicked at tests/server.rs:401:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 22, kind: InvalidInput, message: "Invalid argument" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b9474dcd89a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5b9474dcd89a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5b9474dcd89a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5b9474dcd89a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5b9474df5683 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5b9474df5683 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5b9474dc9ee3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5b9474dcd6e2 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5b9474dced1d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5b9474dceb27 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5b9474c9bf87 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5b9474c9bf87 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5b9474dcf3c8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5b9474dcf3c8 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5b9474dcf18a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5b9474dcdd79 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5b9474dcee1c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5b9474bea250 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5b9474bea696 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x5b9474c4a6bb - core::result::Result<T,E>::unwrap::h4dc6ac19202bacb1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x5b9474c4a6bb - server::start_server::{{closure}}::hcca6bc56f64d5763
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   21:     0x5b9474c54db2 - server::send_error_unknown_command::{{closure}}::hce40937ecdb5bc99
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:338:31
[INFO] [stdout]   22:     0x5b9474c1333f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h345de0421205bf8e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x5b9474c25fb3 - tokio::coop::with_budget::{{closure}}::h116436b401f6b4e1
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   24:     0x5b9474c3887a - std::thread::local::LocalKey<T>::try_with::h02f426b03a08398b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:283:12
[INFO] [stdout]   25:     0x5b9474c3845a - std::thread::local::LocalKey<T>::with::he6e721846f21f826
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/local.rs:260:9
[INFO] [stdout]   26:     0x5b9474c1072f - tokio::coop::with_budget::hab57835cd34ef3c3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   27:     0x5b9474c1072f - tokio::coop::budget::hdae2244f0b785158
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   28:     0x5b9474c1072f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h3839515d7fb80269
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   29:     0x5b9474c14e8e - tokio::runtime::basic_scheduler::enter::{{closure}}::ha1504af11ed0045e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   30:     0x5b9474c3b4e7 - tokio::macros::scoped_tls::ScopedKey<T>::set::ha0093466cba666f2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   31:     0x5b9474c1423e - tokio::runtime::basic_scheduler::enter::h56a7080781676848
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   32:     0x5b9474c10440 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::haacdd6b325e45e61
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   33:     0x5b9474c0a765 - tokio::runtime::Runtime::block_on::{{closure}}::hc6432de628764271
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   34:     0x5b9474c3bb24 - tokio::runtime::context::enter::h8757b5ccc598e5b3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   35:     0x5b9474bfe09c - tokio::runtime::handle::Handle::enter::haa0edcd3d74c0e54
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   36:     0x5b9474c0a177 - tokio::runtime::Runtime::block_on::h4f68b1b2ec5a27dd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   37:     0x5b9474c54b6a - server::send_error_unknown_command::hab0f63174f5af9a9
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:336:1
[INFO] [stdout]   38:     0x5b9474c549d7 - server::send_error_unknown_command::{{closure}}::hb38ee6b22d9f9dfd
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:337:38
[INFO] [stdout]   39:     0x5b9474beae46 - core::ops::function::FnOnce::call_once::h1ac93e46248aa515
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5b9474ca0aab - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b9474ca0aab - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   42:     0x5b9474ca0498 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   43:     0x5b9474ca0498 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x5b9474ca0498 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   45:     0x5b9474ca0498 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   46:     0x5b9474ca0498 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   47:     0x5b9474ca0498 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   48:     0x5b9474ca0498 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   49:     0x5b9474c63f3a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   50:     0x5b9474c63f3a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   51:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   52:     0x5b9474c678b4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x5b9474c678b4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   54:     0x5b9474c678b4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   55:     0x5b9474c678b4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   56:     0x5b9474c678b4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   57:     0x5b9474c678b4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   59:     0x5b9474dd347b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   60:     0x5b9474dd347b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   61:     0x7cc94c581ac3 - <unknown>
[INFO] [stdout]   62:     0x7cc94c612a04 - clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     key_value_get_set
[INFO] [stdout]     key_value_timeout
[INFO] [stdout]     manage_subscription
[INFO] [stdout]     pub_sub
[INFO] [stdout]     send_error_get_set_after_subscribe
[INFO] [stdout]     send_error_unknown_command
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "13b41a57a850e4dd9b1bb395ce9114e3ce96e138d9a9efa8ac45689a3d9423e1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "13b41a57a850e4dd9b1bb395ce9114e3ce96e138d9a9efa8ac45689a3d9423e1", kill_on_drop: false }`
[INFO] [stdout] 13b41a57a850e4dd9b1bb395ce9114e3ce96e138d9a9efa8ac45689a3d9423e1
