[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 1.75.0 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphotoszzt%2Fcache_server" "/workspace/builds/worker-0-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/photoszzt/cache_server on toolchain 1.75.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.75.0" "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-0-tc1/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" "+1.75.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tracing-subscriber v0.2.13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] aa9378514ec30f8e0c2d35fcc4f4995457de1fb1fa2224dcf96a982ef694a427
[INFO] running `Command { std: "docker" "start" "-a" "aa9378514ec30f8e0c2d35fcc4f4995457de1fb1fa2224dcf96a982ef694a427", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "aa9378514ec30f8e0c2d35fcc4f4995457de1fb1fa2224dcf96a982ef694a427", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aa9378514ec30f8e0c2d35fcc4f4995457de1fb1fa2224dcf96a982ef694a427", kill_on_drop: false }`
[INFO] [stdout] aa9378514ec30f8e0c2d35fcc4f4995457de1fb1fa2224dcf96a982ef694a427
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e79d44959a83a6cd5601f42edf6dde472f62181c9eb3287269334fde77c0aff0
[INFO] running `Command { std: "docker" "start" "-a" "e79d44959a83a6cd5601f42edf6dde472f62181c9eb3287269334fde77c0aff0", 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 regex-syntax v0.6.18
[INFO] [stderr]    Compiling proc-macro-hack v0.5.18
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling tracing-core v0.1.17
[INFO] [stderr]    Compiling pin-project-internal v0.4.25
[INFO] [stderr]    Compiling slab v0.4.2
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling arc-swap v0.4.7
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[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 serde_json v1.0.58
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling bytes v0.5.6
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling futures-core v0.3.5
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling tracing-log v0.1.1
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling textwrap v0.12.1
[INFO] [stderr]    Compiling sharded-slab v0.0.9
[INFO] [stderr]    Compiling futures-sink v0.3.6
[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 mio v0.6.22
[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 ansi_term v0.12.1
[INFO] [stderr]    Compiling termcolor v1.1.0
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling os_str_bytes v2.3.2
[INFO] [stderr]    Compiling linked-hash-map v0.5.3
[INFO] [stderr]    Compiling const-random v0.1.8
[INFO] [stderr]    Compiling ahash v0.3.8
[INFO] [stderr]    Compiling mio-uds v0.6.8
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling dashmap v3.11.10
[INFO] [stderr]    Compiling regex-automata v0.1.9
[INFO] [stderr]    Compiling regex v1.3.9
[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 tracing v0.1.21
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling tracing-subscriber v0.2.13
[INFO] [stderr]    Compiling pin-project v0.4.25
[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] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.01s
[INFO] running `Command { std: "docker" "inspect" "e79d44959a83a6cd5601f42edf6dde472f62181c9eb3287269334fde77c0aff0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e79d44959a83a6cd5601f42edf6dde472f62181c9eb3287269334fde77c0aff0", kill_on_drop: false }`
[INFO] [stdout] e79d44959a83a6cd5601f42edf6dde472f62181c9eb3287269334fde77c0aff0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ef7f8b9d204d28379e9838e42100d32314d273105f81d5248b327fe33fc5ad6d
[INFO] running `Command { std: "docker" "start" "-a" "ef7f8b9d204d28379e9838e42100d32314d273105f81d5248b327fe33fc5ad6d", 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 rand v0.7.3
[INFO] [stderr]    Compiling const-random v0.1.8
[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] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.52s
[INFO] running `Command { std: "docker" "inspect" "ef7f8b9d204d28379e9838e42100d32314d273105f81d5248b327fe33fc5ad6d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ef7f8b9d204d28379e9838e42100d32314d273105f81d5248b327fe33fc5ad6d", kill_on_drop: false }`
[INFO] [stdout] ef7f8b9d204d28379e9838e42100d32314d273105f81d5248b327fe33fc5ad6d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b49a975ccf8f690c20e83d91b25eed9d0a6e39a3a9bb2f5dff4784907eadc6e9
[INFO] running `Command { std: "docker" "start" "-a" "b49a975ccf8f690c20e83d91b25eed9d0a6e39a3a9bb2f5dff4784907eadc6e9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lrucache-659325b64b25c97f)
[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_array ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_int ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_error ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_simple_string ... ok
[INFO] [stdout] test lrucache::tests::test_change_capacity ... ok
[INFO] [stdout] test lrucache::tests::test_contains_key ... ok
[INFO] [stdout] test lrucache::tests::test_debug ... ok
[INFO] [stdout] test lrucache::tests::test_iter ... ok
[INFO] [stdout] test lrucache::tests::test_expire_lru ... ok
[INFO] [stdout] test lrucache::tests::test_clear ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_reinsert_larger ... 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_remove ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_oversize ... ok
[INFO] [stdout] test lrucache::tests::test_pop ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache ... ok
[INFO] [stdout] test cache::tests::test_meta_sadd_duplicate ... 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 ... ok
[INFO] [stdout] test cache::tests::test_remove ... 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.27s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/server.rs (/opt/rustwide/target/debug/deps/cache_server-0028a1f60602c775)
[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-4479efabbc5e0e88)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test key_value_timeout ... FAILED
[INFO] [stdout] test pub_sub ... FAILED
[INFO] [stdout] test send_error_get_set_after_subscribe ... FAILED
[INFO] [stdout] test key_value_get_set ... FAILED
[INFO] [stdout] test manage_subscription ... FAILED
[INFO] [stdout] test send_error_unknown_command ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4da426 - server::key_value_timeout::{{closure}}::hacff565e3badbc1e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:71:31
[INFO] [stdout]   23:     0x55bb1b5074e4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h66c5910cf324bcfb
[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]   24:     0x55bb1b4c75c0 - tokio::coop::with_budget::{{closure}}::ha6a72db2ac9907db
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4aa15e - std::thread::local::LocalKey<T>::try_with::h4c49af8d7ee4bd38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a938a - std::thread::local::LocalKey<T>::with::h9bb5a5689e9a8fb2
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b506488 - tokio::coop::with_budget::h19e26fa90ee46e60
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b506488 - tokio::coop::budget::h30f7856d2eae9ca4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b506488 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hacd948659cd9b3c8
[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]   30:     0x55bb1b509081 - tokio::runtime::basic_scheduler::enter::{{closure}}::heab99d862dd29aff
[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]   31:     0x55bb1b4a30f3 - tokio::macros::scoped_tls::ScopedKey<T>::set::h55f492a5cd89f6fa
[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]   32:     0x55bb1b5089f5 - tokio::runtime::basic_scheduler::enter::hbf6c40cbae014994
[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]   33:     0x55bb1b504020 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h32f89b6dd348c7d8
[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]   34:     0x55bb1b501880 - tokio::runtime::Runtime::block_on::{{closure}}::h955281072ceb2b7b
[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]   35:     0x55bb1b4ae534 - tokio::runtime::context::enter::h8052061bdbb18ae5
[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]   36:     0x55bb1b4c417c - tokio::runtime::handle::Handle::enter::h03933a5d65db1f55
[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]   37:     0x55bb1b501479 - tokio::runtime::Runtime::block_on::heda0d78edde5929d
[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]   38:     0x55bb1b4da14e - server::key_value_timeout::h95e1a7920ad9c383
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:67:1
[INFO] [stdout]   39:     0x55bb1b4da077 - server::key_value_timeout::{{closure}}::h608287b5fe3dc22b
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:68:29
[INFO] [stdout]   40:     0x55bb1b4914c6 - core::ops::function::FnOnce::call_once::h90afbe390e82d710
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4db5f9 - server::pub_sub::{{closure}}::hfc8b8f4d2aada03a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:124:31
[INFO] [stdout]   23:     0x55bb1b5077d4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hf158f2bf89119f00
[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]   24:     0x55bb1b4c7a80 - tokio::coop::with_budget::{{closure}}::hd19ba6d52c9b9738
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4ac77e - std::thread::local::LocalKey<T>::try_with::hf9086daaf222efe3
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a95ca - std::thread::local::LocalKey<T>::with::hed613013e98517f2
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b504c38 - tokio::coop::with_budget::h2fca95b10456a56f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b504c38 - tokio::coop::budget::h386612492d294265
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b504c38 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h3ad559ef8b299b3b
[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]   30:     0x55bb1b508ebc - tokio::runtime::basic_scheduler::enter::{{closure}}::h2a00123bf92f48d6
[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]   31:     0x55bb1b4a3351 - tokio::macros::scoped_tls::ScopedKey<T>::set::hc45850cb9c5b91f6
[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]   32:     0x55bb1b5082d5 - tokio::runtime::basic_scheduler::enter::h813b8e205d633479
[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]   33:     0x55bb1b504062 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h3eb7e51ad2bf1a54
[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]   34:     0x55bb1b50154c - tokio::runtime::Runtime::block_on::{{closure}}::h23ef37064f6a1886
[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]   35:     0x55bb1b4ae314 - tokio::runtime::context::enter::h433a8899b8930e57
[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]   36:     0x55bb1b4c43ba - tokio::runtime::handle::Handle::enter::h7317ef394ce2fcdb
[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]   37:     0x55bb1b50129c - tokio::runtime::Runtime::block_on::h5ebcf8afaffb76a7
[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]   38:     0x55bb1b4db200 - server::pub_sub::heaba3deded149b4e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:122:1
[INFO] [stdout]   39:     0x55bb1b4db127 - server::pub_sub::{{closure}}::hf6bd3e0aeec05632
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:123:19
[INFO] [stdout]   40:     0x55bb1b491656 - core::ops::function::FnOnce::call_once::hda6650745a35d2cb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4e0f56 - server::send_error_get_set_after_subscribe::{{closure}}::hbc70bd9b1def5e74
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:360:31
[INFO] [stdout]   23:     0x55bb1b5073f4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h493af80f260cbb83
[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]   24:     0x55bb1b4c6fd0 - tokio::coop::with_budget::{{closure}}::h59ad94b64b52f7f1
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4aa89e - std::thread::local::LocalKey<T>::try_with::h5e2f20a3a1dd1b42
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a90ba - std::thread::local::LocalKey<T>::with::h38e324dca74944f4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b504428 - tokio::coop::with_budget::h50c9444574fca0dd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b504428 - tokio::coop::budget::h2aad2dad172aa9bd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b504428 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h03303d7439c986a0
[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]   30:     0x55bb1b508f2f - tokio::runtime::basic_scheduler::enter::{{closure}}::h340ac6a118c47843
[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]   31:     0x55bb1b4a3221 - tokio::macros::scoped_tls::ScopedKey<T>::set::h62c63021ce1194db
[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]   32:     0x55bb1b508d85 - tokio::runtime::basic_scheduler::enter::hf0e2d351a3c813ae
[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]   33:     0x55bb1b5040e2 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h7d18f3c97ddd6dea
[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]   34:     0x55bb1b501990 - tokio::runtime::Runtime::block_on::{{closure}}::hc1d15b1263d22a51
[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]   35:     0x55bb1b4ae424 - tokio::runtime::context::enter::h74543f79d94e64d8
[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]   36:     0x55bb1b4c447a - tokio::runtime::handle::Handle::enter::h9c99a5df05af9499
[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]   37:     0x55bb1b5012fb - tokio::runtime::Runtime::block_on::h6a54f5e43acd98e8
[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]   38:     0x55bb1b4e0ca0 - server::send_error_get_set_after_subscribe::h342fac7f3ba78c30
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:358:1
[INFO] [stdout]   39:     0x55bb1b4e0bc7 - server::send_error_get_set_after_subscribe::{{closure}}::hfd4522369b8e2437
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:359:46
[INFO] [stdout]   40:     0x55bb1b491166 - core::ops::function::FnOnce::call_once::h4beac99953a4fbb2
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                0x0 - <unknown>
[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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4d92ab - server::key_value_get_set::{{closure}}::h24e946b1058c5aa6
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:14:31
[INFO] [stdout]   23:     0x55bb1b5075c4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hd42fd303c20608ee
[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]   24:     0x55bb1b4c68b0 - tokio::coop::with_budget::{{closure}}::h26a0089e1aefd538
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4abf7e - std::thread::local::LocalKey<T>::try_with::hcf99764322eeecd3
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a908a - std::thread::local::LocalKey<T>::with::h332e78b91acc77ce
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b505c68 - tokio::coop::with_budget::h86f5d5ac786aba6d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b505c68 - tokio::coop::budget::he132c9c2150ddc73
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b505c68 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h6c419468d5fb7648
[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]   30:     0x55bb1b508fa1 - tokio::runtime::basic_scheduler::enter::{{closure}}::hc2b556637f136665
[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]   31:     0x55bb1b4a3483 - tokio::macros::scoped_tls::ScopedKey<T>::set::hf25d7d65e5224848
[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]   32:     0x55bb1b507f45 - tokio::runtime::basic_scheduler::enter::h2e2204397b76f880
[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]   33:     0x55bb1b503fe0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h2db5f7194ccfb761
[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]   34:     0x55bb1b501660 - tokio::runtime::Runtime::block_on::{{closure}}::h585f30e8be19e054
[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]   35:     0x55bb1b4ae644 - tokio::runtime::context::enter::hd1f646647352121e
[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]   36:     0x55bb1b4c42fc - tokio::runtime::handle::Handle::enter::h3a1e31f58f368231
[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]   37:     0x55bb1b501419 - tokio::runtime::Runtime::block_on::he47abc0591d90edd
[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]   38:     0x55bb1b4d8fde - server::key_value_get_set::h4fda51f37c28a7ae
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:12:1
[INFO] [stdout]   39:     0x55bb1b4d8f07 - server::key_value_get_set::{{closure}}::he6003a1e40c2eb65
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:13:29
[INFO] [stdout]   40:     0x55bb1b4915d6 - core::ops::function::FnOnce::call_once::hc720b5303b8f476d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4de4b0 - server::manage_subscription::{{closure}}::hfc5acb96298030bf
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:247:31
[INFO] [stdout]   23:     0x55bb1b507794 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::heed7538a732bb1c1
[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]   24:     0x55bb1b4c6ea0 - tokio::coop::with_budget::{{closure}}::h5449b58648b482a3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4aaebe - std::thread::local::LocalKey<T>::try_with::h6f40fb1c72a80097
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a955a - std::thread::local::LocalKey<T>::with::hdb1c7c0410c1fd50
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b506ca8 - tokio::coop::with_budget::h881cc0a542ed9ef8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b506ca8 - tokio::coop::budget::ha4b3ad8473ae808f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b506ca8 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::he46eed5040e067db
[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]   30:     0x55bb1b50900e - tokio::runtime::basic_scheduler::enter::{{closure}}::hc7f57c3cc23f678f
[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]   31:     0x55bb1b4a2fc3 - tokio::macros::scoped_tls::ScopedKey<T>::set::h15808ce9679f3251
[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]   32:     0x55bb1b508665 - tokio::runtime::basic_scheduler::enter::h9bb9b37fa020480e
[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]   33:     0x55bb1b5040a0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h51ac03117f4d35c7
[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]   34:     0x55bb1b501a9c - tokio::runtime::Runtime::block_on::{{closure}}::hc7a9daf03af3bd34
[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]   35:     0x55bb1b4ae204 - tokio::runtime::context::enter::h296c79ebf78fbe5c
[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]   36:     0x55bb1b4c423c - tokio::runtime::handle::Handle::enter::h346663c3b0161e9e
[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]   37:     0x55bb1b5013ba - tokio::runtime::Runtime::block_on::hcb146b84e89d6016
[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]   38:     0x55bb1b4de11e - server::manage_subscription::h9f255baddfb70e9a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:245:1
[INFO] [stdout]   39:     0x55bb1b4de047 - server::manage_subscription::{{closure}}::h5be63ba3d6eaa5bf
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:246:31
[INFO] [stdout]   40:     0x55bb1b491346 - core::ops::function::FnOnce::call_once::h7990e14afea0b912
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                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:     0x55bb1b68704c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55bb1b68704c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55bb1b68704c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55bb1b68704c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55bb1b6b31a0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55bb1b6b31a0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55bb1b683e8f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55bb1b686e34 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55bb1b686e34 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55bb1b688af7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55bb1b6887e3 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55bb1b541017 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x55bb1b541017 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55bb1b689108 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x55bb1b689108 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55bb1b688e5e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55bb1b687516 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x55bb1b688bc2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55bb1b4904f5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55bb1b490a83 - core::result::unwrap_failed::hddb4fea594200c52
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1653:5
[INFO] [stdout]   20:     0x55bb1b4e23b0 - core::result::Result<T,E>::unwrap::h3d8dfccb42b62fcb
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/result.rs:1077:23
[INFO] [stdout]   21:     0x55bb1b4d8a7c - server::start_server::{{closure}}::h9d2398434c294192
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x55bb1b4e06ac - server::send_error_unknown_command::{{closure}}::hfc46aa9d7002bddb
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:338:31
[INFO] [stdout]   23:     0x55bb1b5072f4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h363c7294693632f9
[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]   24:     0x55bb1b4c7ce0 - tokio::coop::with_budget::{{closure}}::hd5ef24fed6dce0a8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x55bb1b4a977e - std::thread::local::LocalKey<T>::try_with::h0b8ac146fe9b5729
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x55bb1b4a914a - std::thread::local::LocalKey<T>::with::h4c176e5087dc18b5
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x55bb1b505448 - tokio::coop::with_budget::h68cfa8bedeb01de3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x55bb1b505448 - tokio::coop::budget::hc38c348aaf7acbdf
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x55bb1b505448 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h68b399b890f3a209
[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]   30:     0x55bb1b508e51 - tokio::runtime::basic_scheduler::enter::{{closure}}::h25f781378fd9e2d6
[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]   31:     0x55bb1b4a35b3 - tokio::macros::scoped_tls::ScopedKey<T>::set::hfcdf54444c8f08e4
[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]   32:     0x55bb1b507bb5 - tokio::runtime::basic_scheduler::enter::h26e4c5d4cd139226
[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]   33:     0x55bb1b504120 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::hdf563a55980d5ea9
[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]   34:     0x55bb1b501770 - tokio::runtime::Runtime::block_on::{{closure}}::h69526216a87a3aa8
[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]   35:     0x55bb1b4ae754 - tokio::runtime::context::enter::hf6b334cdb11ec1e7
[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]   36:     0x55bb1b4c453c - tokio::runtime::handle::Handle::enter::ha32c2fb5d8c75667
[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]   37:     0x55bb1b501359 - tokio::runtime::Runtime::block_on::ha1a5544fbf7fe89a
[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]   38:     0x55bb1b4e047e - server::send_error_unknown_command::h08afbc1e7b2f3f36
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:336:1
[INFO] [stdout]   39:     0x55bb1b4e03a7 - server::send_error_unknown_command::{{closure}}::h7a1a7485c15ab718
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:337:38
[INFO] [stdout]   40:     0x55bb1b491096 - core::ops::function::FnOnce::call_once::h3ab318f8185b4384
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55bb1b54666f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55bb1b54666f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   43:     0x55bb1b545685 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   44:     0x55bb1b545685 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55bb1b545685 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55bb1b545685 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55bb1b545685 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55bb1b545685 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   49:     0x55bb1b545685 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   50:     0x55bb1b50d946 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   51:     0x55bb1b50d946 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   52:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x55bb1b5129f7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x55bb1b5129f7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x55bb1b5129f7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x55bb1b5129f7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x55bb1b5129f7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x55bb1b5129f7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   60:     0x55bb1b68dcf5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   61:     0x55bb1b68dcf5 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7fafaeaa1ac3 - <unknown>
[INFO] [stdout]   63:     0x7fafaeb32bf4 - __clone
[INFO] [stdout]   64:                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.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test server`
[INFO] running `Command { std: "docker" "inspect" "b49a975ccf8f690c20e83d91b25eed9d0a6e39a3a9bb2f5dff4784907eadc6e9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b49a975ccf8f690c20e83d91b25eed9d0a6e39a3a9bb2f5dff4784907eadc6e9", kill_on_drop: false }`
[INFO] [stdout] b49a975ccf8f690c20e83d91b25eed9d0a6e39a3a9bb2f5dff4784907eadc6e9
[INFO] testing photoszzt/cache_server against beta-2023-12-22 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphotoszzt%2Fcache_server" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/photoszzt/cache_server on toolchain beta-2023-12-22
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-12-22" "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-0-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-2023-12-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1c05d23ec08a190947202ccb0d272b245d383009768602227632cba35f912ec6
[INFO] running `Command { std: "docker" "start" "-a" "1c05d23ec08a190947202ccb0d272b245d383009768602227632cba35f912ec6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1c05d23ec08a190947202ccb0d272b245d383009768602227632cba35f912ec6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1c05d23ec08a190947202ccb0d272b245d383009768602227632cba35f912ec6", kill_on_drop: false }`
[INFO] [stdout] 1c05d23ec08a190947202ccb0d272b245d383009768602227632cba35f912ec6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d3d8ff5cdc3e1b84b14a68f823403208fa95bacdc8f131ca95e2aba91b2fbe0e
[INFO] running `Command { std: "docker" "start" "-a" "d3d8ff5cdc3e1b84b14a68f823403208fa95bacdc8f131ca95e2aba91b2fbe0e", 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 serde v1.0.116
[INFO] [stderr]    Compiling byteorder v1.3.4
[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 memchr v2.3.3
[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 arc-swap v0.4.7
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[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 heck v0.3.1
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling bytes v0.5.6
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling futures-core v0.3.5
[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 quote v1.0.7
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling net2 v0.2.35
[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 strsim v0.10.0
[INFO] [stderr]    Compiling smallvec v1.4.2
[INFO] [stderr]    Compiling termcolor v1.1.0
[INFO] [stderr]    Compiling mio v0.6.22
[INFO] [stderr]    Compiling os_str_bytes v2.3.2
[INFO] [stderr]    Compiling futures-sink v0.3.6
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling linked-hash-map v0.5.3
[INFO] [stderr]    Compiling const-random v0.1.8
[INFO] [stderr]    Compiling ahash v0.3.8
[INFO] [stderr]    Compiling dashmap v3.11.10
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling regex-automata v0.1.9
[INFO] [stderr]    Compiling regex v1.3.9
[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 thiserror-impl v1.0.21
[INFO] [stderr]    Compiling clap_derive v3.0.0-beta.2
[INFO] [stderr]    Compiling tokio v0.2.22
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling tracing v0.1.21
[INFO] [stderr]    Compiling tracing-subscriber v0.2.13
[INFO] [stderr]    Compiling pin-project v0.4.25
[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] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.61s
[INFO] running `Command { std: "docker" "inspect" "d3d8ff5cdc3e1b84b14a68f823403208fa95bacdc8f131ca95e2aba91b2fbe0e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d3d8ff5cdc3e1b84b14a68f823403208fa95bacdc8f131ca95e2aba91b2fbe0e", kill_on_drop: false }`
[INFO] [stdout] d3d8ff5cdc3e1b84b14a68f823403208fa95bacdc8f131ca95e2aba91b2fbe0e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2de5ca5bf9f9bddd3410b7c3e0443462715ade7045beb840719b1ec40df45cce
[INFO] running `Command { std: "docker" "start" "-a" "2de5ca5bf9f9bddd3410b7c3e0443462715ade7045beb840719b1ec40df45cce", 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 rand v0.7.3
[INFO] [stderr]    Compiling const-random v0.1.8
[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] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.34s
[INFO] running `Command { std: "docker" "inspect" "2de5ca5bf9f9bddd3410b7c3e0443462715ade7045beb840719b1ec40df45cce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2de5ca5bf9f9bddd3410b7c3e0443462715ade7045beb840719b1ec40df45cce", kill_on_drop: false }`
[INFO] [stdout] 2de5ca5bf9f9bddd3410b7c3e0443462715ade7045beb840719b1ec40df45cce
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c3c582681d6164a145d3710c49d5b16add0dba2ecbab4698ffba1989e32ad1a5
[INFO] running `Command { std: "docker" "start" "-a" "c3c582681d6164a145d3710c49d5b16add0dba2ecbab4698ffba1989e32ad1a5", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lrucache-5a6800837b40c92f)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test frame::resp_parser_tests::test_error ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_bulk_string ... 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_int ... ok
[INFO] [stdout] test lrucache::tests::test_debug ... ok
[INFO] [stdout] test lrucache::tests::test_clear ... ok
[INFO] [stdout] test lrucache::tests::test_contains_key ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_reinsert_larger ... ok
[INFO] [stdout] test lrucache::tests::test_put_update ... ok
[INFO] [stdout] test lrucache::tests::test_put_and_get ... ok
[INFO] [stdout] test lrucache::tests::test_remove ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache_oversize ... ok
[INFO] [stdout] test lrucache::tests::test_expire_lru ... ok
[INFO] [stdout] test lrucache::tests::test_iter ... ok
[INFO] [stdout] test lrucache::tests::test_metered_cache ... ok
[INFO] [stdout] test cache::tests::test_remove ... ok
[INFO] [stdout] test frame::resp_parser_tests::test_simple_string ... ok
[INFO] [stdout] test lrucache::tests::test_pop ... ok
[INFO] [stdout] test cache::tests::test_meta_srem ... ok
[INFO] [stdout] test cache::tests::test_meta_sadd_duplicate ... ok
[INFO] [stdout] test cache::tests::test_get_insert ... ok
[INFO] [stdout] test cache::tests::test_meta_sadd ... ok
[INFO] [stdout] test cache::tests::test_ttl ... ok
[INFO] [stderr]      Running unittests src/bin/server.rs (/opt/rustwide/target/debug/deps/cache_server-74c76859e3663c28)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s
[INFO] [stdout] 
[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-f7cb70c671a757ed)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test key_value_timeout ... FAILED
[INFO] [stdout] test send_error_unknown_command ... FAILED
[INFO] [stdout] test pub_sub ... FAILED
[INFO] [stdout] test manage_subscription ... FAILED
[INFO] [stdout] test send_error_get_set_after_subscribe ... FAILED
[INFO] [stdout] test key_value_get_set ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dc5a70 - server::key_value_timeout::{{closure}}::hc41473d0af24c93b
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:71:31
[INFO] [stdout]   23:     0x5593e5d8c4e4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hdad276572c8b1252
[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]   24:     0x5593e5db9150 - tokio::coop::with_budget::{{closure}}::ha3f1ab997029244f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da0f0e - std::thread::local::LocalKey<T>::try_with::h61d77beb8564c527
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9f3fa - std::thread::local::LocalKey<T>::with::hb9809b7d36bef7f2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d892ef - tokio::coop::with_budget::h07dd45a4b89d1d28
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d892ef - tokio::coop::budget::h22189c49bfd2368f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d892ef - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h07c42821100e56e8
[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]   30:     0x5593e5d8ddb1 - tokio::runtime::basic_scheduler::enter::{{closure}}::haf8355f0c3f60daa
[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]   31:     0x5593e5da97b3 - tokio::macros::scoped_tls::ScopedKey<T>::set::hbe2b316bdc0e52ca
[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]   32:     0x5593e5d8dc0b - tokio::runtime::basic_scheduler::enter::hee2b25e687dfcc10
[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]   33:     0x5593e5d88ea0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h065ea8fabc1af206
[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]   34:     0x5593e5d799f9 - tokio::runtime::Runtime::block_on::{{closure}}::h6905100e24ac6b4d
[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]   35:     0x5593e5d702b4 - tokio::runtime::context::enter::h1a559dcec2262e6d
[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]   36:     0x5593e5d6fe3c - tokio::runtime::handle::Handle::enter::h789e807260f099bc
[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]   37:     0x5593e5d792b6 - tokio::runtime::Runtime::block_on::h1f2e8048622bf2ad
[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]   38:     0x5593e5dc579e - server::key_value_timeout::h7e03417c0c9de622
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:67:1
[INFO] [stdout]   39:     0x5593e5dc56c7 - server::key_value_timeout::{{closure}}::h5e7179ecbec558d3
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:68:29
[INFO] [stdout]   40:     0x5593e5d514c6 - core::ops::function::FnOnce::call_once::hd4850f64e47cd928
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dcbcd6 - server::send_error_unknown_command::{{closure}}::hbed928e1c094b7a5
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:338:31
[INFO] [stdout]   23:     0x5593e5d8c534 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hdf145d6a172023b6
[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]   24:     0x5593e5db8a30 - tokio::coop::with_budget::{{closure}}::h563099822d1abb0a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da12fe - std::thread::local::LocalKey<T>::try_with::h7451829ba9d30ca1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9f20a - std::thread::local::LocalKey<T>::with::h84fd4ef9b52a51db
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d8a32f - tokio::coop::with_budget::hfc9cead281957672
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d8a32f - tokio::coop::budget::h98e5bb1089dc4e50
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d8a32f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h51b37dcd018436d6
[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]   30:     0x5593e5d8de91 - tokio::runtime::basic_scheduler::enter::{{closure}}::hd5cd04c411e4393c
[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]   31:     0x5593e5da91c3 - tokio::macros::scoped_tls::ScopedKey<T>::set::h2bfc5a8ab31d221d
[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]   32:     0x5593e5d8ca3b - tokio::runtime::basic_scheduler::enter::h12ea1f64dad5571a
[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]   33:     0x5593e5d88fe0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h6ac86cfff8ae2697
[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]   34:     0x5593e5d79669 - tokio::runtime::Runtime::block_on::{{closure}}::h2cff74fd039f69ec
[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]   35:     0x5593e5d704d4 - tokio::runtime::context::enter::h9a9051600d42d2d8
[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]   36:     0x5593e5d6fcbc - tokio::runtime::handle::Handle::enter::h5530317ad8ad7d0f
[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]   37:     0x5593e5d79406 - tokio::runtime::Runtime::block_on::hc98ced23cd303b60
[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]   38:     0x5593e5dcbaae - server::send_error_unknown_command::h2d12c7443589f0d5
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:336:1
[INFO] [stdout]   39:     0x5593e5dcb9d7 - server::send_error_unknown_command::{{closure}}::h1a8bb55d88c61c65
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:337:38
[INFO] [stdout]   40:     0x5593e5d510a6 - core::ops::function::FnOnce::call_once::h16ced84db266a2a8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dc6c43 - server::pub_sub::{{closure}}::hab93659da7a0e4d5
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:124:31
[INFO] [stdout]   23:     0x5593e5d8c3d4 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::ha98fe93737ab370e
[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]   24:     0x5593e5db9d30 - tokio::coop::with_budget::{{closure}}::hed9850debfdafd84
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da201e - std::thread::local::LocalKey<T>::try_with::hb69bfe01cc691522
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9f3ca - std::thread::local::LocalKey<T>::with::hb2ff32d7b129dbec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d8b36f - tokio::coop::with_budget::h192feb14480147f9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d8b36f - tokio::coop::budget::h3c3365b1030857e6
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d8b36f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hcd5e0fa62d3140cd
[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]   30:     0x5593e5d8defc - tokio::runtime::basic_scheduler::enter::{{closure}}::heb01686152d2ef43
[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]   31:     0x5593e5da9681 - tokio::macros::scoped_tls::ScopedKey<T>::set::h9e3158d2e1106b03
[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]   32:     0x5593e5d8d87b - tokio::runtime::basic_scheduler::enter::hdf3d069df8c0c554
[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]   33:     0x5593e5d88f62 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h38073ad8866ea701
[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]   34:     0x5593e5d798c5 - tokio::runtime::Runtime::block_on::{{closure}}::h68acbc76ebd7a36c
[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]   35:     0x5593e5d705e4 - tokio::runtime::context::enter::hb54d2aaed0702bf5
[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]   36:     0x5593e5d6ffba - tokio::runtime::handle::Handle::enter::hdff9865ae9c18a86
[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]   37:     0x5593e5d793a9 - tokio::runtime::Runtime::block_on::hb0faafecc7eb1f7d
[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]   38:     0x5593e5dc6850 - server::pub_sub::hf4ef4f2ddb29e776
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:122:1
[INFO] [stdout]   39:     0x5593e5dc6777 - server::pub_sub::{{closure}}::h3de512ae14101687
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:123:19
[INFO] [stdout]   40:     0x5593e5d50fd6 - core::ops::function::FnOnce::call_once::h05f406c7c0332c45
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dc9aea - server::manage_subscription::{{closure}}::h50cbe05b315baadf
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:247:31
[INFO] [stdout]   23:     0x5593e5d8c574 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::he0d38332e1560a4b
[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]   24:     0x5593e5db9020 - tokio::coop::with_budget::{{closure}}::ha28f3022bae04886
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da144e - std::thread::local::LocalKey<T>::try_with::h74fb705a89d3eaad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9f2aa - std::thread::local::LocalKey<T>::with::h9b0a044e5838d419
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d89b0f - tokio::coop::with_budget::h25a0d33c1f8dd893
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d89b0f - tokio::coop::budget::he68462de2d296146
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d89b0f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h26281261bd10bc66
[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]   30:     0x5593e5d8de1e - tokio::runtime::basic_scheduler::enter::{{closure}}::hbecf07b46defd547
[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]   31:     0x5593e5da92f3 - tokio::macros::scoped_tls::ScopedKey<T>::set::h37afe67dc836b3e5
[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]   32:     0x5593e5d8d4eb - tokio::runtime::basic_scheduler::enter::h685bd4bdacd49dcb
[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]   33:     0x5593e5d88f20 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h27e4b5440113f9ab
[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]   34:     0x5593e5d79535 - tokio::runtime::Runtime::block_on::{{closure}}::h0631584230a204ac
[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]   35:     0x5593e5d703c4 - tokio::runtime::context::enter::h535a6e1b15af7ee0
[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]   36:     0x5593e5d6fefc - tokio::runtime::handle::Handle::enter::ha8add52b17dd336d
[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]   37:     0x5593e5d79307 - tokio::runtime::Runtime::block_on::h2cad941cc205ad12
[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]   38:     0x5593e5dc975e - server::manage_subscription::h5ebe471e09abc233
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:245:1
[INFO] [stdout]   39:     0x5593e5dc9687 - server::manage_subscription::{{closure}}::h670106c04013542c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:246:31
[INFO] [stdout]   40:     0x5593e5d513f6 - core::ops::function::FnOnce::call_once::h945fa95ed8b9f7d2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dcc580 - server::send_error_get_set_after_subscribe::{{closure}}::hb9b81aad6962af58
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:360:31
[INFO] [stdout]   23:     0x5593e5d8c214 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h4ba22880eb64400d
[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]   24:     0x5593e5db9870 - tokio::coop::with_budget::{{closure}}::he332aff61fe1144e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da032e - std::thread::local::LocalKey<T>::try_with::h2e63d4a31bb7a994
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9eeca - std::thread::local::LocalKey<T>::with::h0c2813ff001cae73
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d8bb8f - tokio::coop::with_budget::h1ec57c1bcfcb5886
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d8bb8f - tokio::coop::budget::h4203c72ceaae8850
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d8bb8f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hf73e8c249975e710
[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]   30:     0x5593e5d8dccf - tokio::runtime::basic_scheduler::enter::{{closure}}::h0959f6fe8e4f9e6e
[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]   31:     0x5593e5da9551 - tokio::macros::scoped_tls::ScopedKey<T>::set::h90eac6089563e234
[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]   32:     0x5593e5d8cdcb - tokio::runtime::basic_scheduler::enter::h1fbe817b2131cfd4
[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]   33:     0x5593e5d88fa2 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h526bd600404d514d
[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]   34:     0x5593e5d79b29 - tokio::runtime::Runtime::block_on::{{closure}}::hb255989c6061cac4
[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]   35:     0x5593e5d70094 - tokio::runtime::context::enter::h0ed84510e2f9b8a2
[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]   36:     0x5593e5d6fbfa - tokio::runtime::handle::Handle::enter::h0d44ee227dcc427b
[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]   37:     0x5593e5d79458 - tokio::runtime::Runtime::block_on::hdfece37a398e31d0
[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]   38:     0x5593e5dcc2d0 - server::send_error_get_set_after_subscribe::h4cd7bbcde6af43d3
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:358:1
[INFO] [stdout]   39:     0x5593e5dcc1f7 - server::send_error_get_set_after_subscribe::{{closure}}::hd989075f5c688c2e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:359:46
[INFO] [stdout]   40:     0x5593e5d516a6 - core::ops::function::FnOnce::call_once::hf864b1ef4e709173
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                0x0 - <unknown>
[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:     0x5593e5f45856 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x5593e5f45856 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5593e5f45856 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x5593e5f45856 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x5593e5f70c90 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5593e5f70c90 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5593e5f4276f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x5593e5f45634 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5593e5f45634 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5593e5f473a7 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x5593e5f4708d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5593e5e01b17 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x5593e5e01b17 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x5593e5f479c6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x5593e5f479c6 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x5593e5f47712 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x5593e5f45d56 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x5593e5f47470 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x5593e5d504e5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x5593e5d50a83 - core::result::unwrap_failed::hbe14f498be1452f9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x5593e5d7f9d0 - core::result::Result<T,E>::unwrap::ha98703a42c8ccd1e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/result.rs:1073:23
[INFO] [stdout]   21:     0x5593e5dc40f6 - server::start_server::{{closure}}::h298cd928d3bba48e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:401:20
[INFO] [stdout]   22:     0x5593e5dc4905 - server::key_value_get_set::{{closure}}::he6008adebbd1533b
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:14:31
[INFO] [stdout]   23:     0x5593e5d8c704 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hfc40d110c7ec3c7c
[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]   24:     0x5593e5db99a0 - tokio::coop::with_budget::{{closure}}::he8b36f72241928af
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   25:     0x5593e5da0b1e - std::thread::local::LocalKey<T>::try_with::h4fe080d6a42c13dc
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   26:     0x5593e5d9ef6a - std::thread::local::LocalKey<T>::with::h1fcf2e99efd9b1cc
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   27:     0x5593e5d8ab4f - tokio::coop::with_budget::h5051829e1a3a60b3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   28:     0x5593e5d8ab4f - tokio::coop::budget::h62447d4426fc1b77
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   29:     0x5593e5d8ab4f - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h98d7372bf5b4fe20
[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]   30:     0x5593e5d8dd41 - tokio::runtime::basic_scheduler::enter::{{closure}}::h4da69eb703d4d79f
[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]   31:     0x5593e5da9423 - tokio::macros::scoped_tls::ScopedKey<T>::set::h6af08fae519eb23e
[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]   32:     0x5593e5d8d15b - tokio::runtime::basic_scheduler::enter::h5fb9ad22575f3242
[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]   33:     0x5593e5d88ee0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h206923f40baa37f4
[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]   34:     0x5593e5d79799 - tokio::runtime::Runtime::block_on::{{closure}}::h4670ff57bab53e5a
[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]   35:     0x5593e5d701a4 - tokio::runtime::context::enter::h12b4c42f9d4ee827
[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]   36:     0x5593e5d6fd7c - tokio::runtime::handle::Handle::enter::h6bf0a9fa5defcaa8
[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]   37:     0x5593e5d79356 - tokio::runtime::Runtime::block_on::h2fc42ace68546d38
[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]   38:     0x5593e5dc463e - server::key_value_get_set::h301a1dae7d338898
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:12:1
[INFO] [stdout]   39:     0x5593e5dc4567 - server::key_value_get_set::{{closure}}::h0fc20cb43233376a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/server.rs:13:29
[INFO] [stdout]   40:     0x5593e5d51286 - core::ops::function::FnOnce::call_once::h5c932e07ff00d138
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5593e5e073ef - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5593e5e073ef - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   43:     0x5593e5e06171 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   44:     0x5593e5e06171 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x5593e5e06171 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x5593e5e06171 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x5593e5e06171 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x5593e5e06171 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   49:     0x5593e5e06171 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   50:     0x5593e5dcd4a6 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   51:     0x5593e5dcd4a6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   52:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   53:     0x5593e5dd2507 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   54:     0x5593e5dd2507 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   55:     0x5593e5dd2507 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   56:     0x5593e5dd2507 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   57:     0x5593e5dd2507 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   58:     0x5593e5dd2507 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   59:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x5593e5f4c5d5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   61:     0x5593e5f4c5d5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   62:     0x7f34e79a0ac3 - <unknown>
[INFO] [stdout]   63:     0x7f34e7a31bf4 - __clone
[INFO] [stdout]   64:                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] [stderr] error: test failed, to rerun pass `--test server`
[INFO] running `Command { std: "docker" "inspect" "c3c582681d6164a145d3710c49d5b16add0dba2ecbab4698ffba1989e32ad1a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c3c582681d6164a145d3710c49d5b16add0dba2ecbab4698ffba1989e32ad1a5", kill_on_drop: false }`
[INFO] [stdout] c3c582681d6164a145d3710c49d5b16add0dba2ecbab4698ffba1989e32ad1a5
