[INFO] cloning repository https://github.com/rapiz1/rathole [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rapiz1/rathole" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frapiz1%2Frathole", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frapiz1%2Frathole'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 0ee0157b4b9584580dde07a351982d87880f2404 [INFO] testing rapiz1/rathole/0ee0157b4b9584580dde07a351982d87880f2404 against master#61223975d46f794466efa832bc7562b9707ecc46+rustflags=-Copt-level=3 for pr-121282 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frapiz1%2Frathole" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/rapiz1/rathole on toolchain 61223975d46f794466efa832bc7562b9707ecc46 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+61223975d46f794466efa832bc7562b9707ecc46" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/rapiz1/rathole [INFO] finished tweaking git repo https://github.com/rapiz1/rathole [INFO] tweaked toml for git repo https://github.com/rapiz1/rathole written to /workspace/builds/worker-4-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/rapiz1/rathole 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" "+61223975d46f794466efa832bc7562b9707ecc46" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded async-socks5 v0.5.1 [INFO] [stderr] Downloaded snowstorm v0.4.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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" "+61223975d46f794466efa832bc7562b9707ecc46" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 50579ce780d6632be6163d088e9c69c308a7cb7d58d5f2bed44c8cdbeab49712 [INFO] running `Command { std: "docker" "start" "-a" "50579ce780d6632be6163d088e9c69c308a7cb7d58d5f2bed44c8cdbeab49712", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "50579ce780d6632be6163d088e9c69c308a7cb7d58d5f2bed44c8cdbeab49712", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "50579ce780d6632be6163d088e9c69c308a7cb7d58d5f2bed44c8cdbeab49712", kill_on_drop: false }` [INFO] [stdout] 50579ce780d6632be6163d088e9c69c308a7cb7d58d5f2bed44c8cdbeab49712 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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=forbid -Copt-level=3" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+61223975d46f794466efa832bc7562b9707ecc46" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 183d432e2a1c30a1eda6b4b7c92a2e931f8cd328c23215b4512b4453343ad183 [INFO] running `Command { std: "docker" "start" "-a" "183d432e2a1c30a1eda6b4b7c92a2e931f8cd328c23215b4512b4453343ad183", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.148 [INFO] [stderr] Compiling proc-macro2 v1.0.67 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling pkg-config v0.3.27 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling subtle v2.5.0 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling syn v2.0.37 [INFO] [stderr] Compiling getrandom v0.2.10 [INFO] [stderr] Compiling jobserver v0.1.26 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling cpufeatures v0.2.9 [INFO] [stderr] Compiling lock_api v0.4.10 [INFO] [stderr] Compiling thiserror v1.0.49 [INFO] [stderr] Compiling parking_lot_core v0.9.8 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling smallvec v1.11.1 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling semver v1.0.19 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling mio v0.8.8 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling zeroize v1.6.0 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling once_cell v1.18.0 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling inout v0.1.3 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling socket2 v0.5.4 [INFO] [stderr] Compiling signal-hook-registry v1.4.1 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling anyhow v1.0.75 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling cipher v0.4.4 [INFO] [stderr] Compiling rustc_version v0.4.0 [INFO] [stderr] Compiling universal-hash v0.5.1 [INFO] [stderr] Compiling rustversion v1.0.14 [INFO] [stderr] Compiling futures-core v0.3.28 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling unicode-normalization v0.1.22 [INFO] [stderr] Compiling deranged v0.3.8 [INFO] [stderr] Compiling time-core v0.1.2 [INFO] [stderr] Compiling unicode-bidi v0.3.13 [INFO] [stderr] Compiling percent-encoding v2.3.0 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling idna v0.4.0 [INFO] [stderr] Compiling form_urlencoded v1.2.0 [INFO] [stderr] Compiling time v0.3.29 [INFO] [stderr] Compiling libz-sys v1.1.12 [INFO] [stderr] Compiling openssl-sys v0.9.93 [INFO] [stderr] Compiling libgit2-sys v0.14.2+1.5.1 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling futures-task v0.3.28 [INFO] [stderr] Compiling httparse v1.8.0 [INFO] [stderr] Compiling platforms v3.1.2 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling url v2.4.1 [INFO] [stderr] Compiling curve25519-dalek v4.1.2 [INFO] [stderr] Compiling polyval v0.6.1 [INFO] [stderr] Compiling aead v0.5.2 [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling futures-sink v0.3.28 [INFO] [stderr] Compiling openssl v0.10.57 [INFO] [stderr] Compiling futures-util v0.3.28 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling ghash v0.5.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling vergen v7.5.1 [INFO] [stderr] Compiling snow v0.9.6 [INFO] [stderr] Compiling poly1305 v0.8.0 [INFO] [stderr] Compiling aes v0.8.4 [INFO] [stderr] Compiling chacha20 v0.9.1 [INFO] [stderr] Compiling ctr v0.9.2 [INFO] [stderr] Compiling tracing-core v0.1.31 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling async-trait v0.1.73 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling native-tls v0.2.11 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling regex-syntax v0.7.5 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling bitflags v2.4.0 [INFO] [stderr] Compiling aes-gcm v0.10.3 [INFO] [stderr] Compiling chacha20poly1305 v0.10.1 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling blake2 v0.10.6 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling data-encoding v2.4.0 [INFO] [stderr] Compiling regex-automata v0.3.9 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling os_str_bytes v6.5.1 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling utf-8 v0.7.6 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling regex v1.9.6 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling walkdir v2.4.0 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling inotify v0.9.6 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling sharded-slab v0.1.6 [INFO] [stderr] Compiling tracing-log v0.1.3 [INFO] [stderr] Compiling thread_local v1.1.7 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling filetime v0.2.22 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling textwrap v0.16.0 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling termcolor v1.3.0 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling notify v5.2.0 [INFO] [stderr] Compiling socket2 v0.4.9 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling getset v0.1.2 [INFO] [stderr] Compiling serde_derive v1.0.188 [INFO] [stderr] Compiling thiserror-impl v1.0.49 [INFO] [stderr] Compiling tokio-macros v2.1.0 [INFO] [stderr] Compiling enum-iterator-derive v1.2.1 [INFO] [stderr] Compiling curve25519-dalek-derive v0.1.0 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling futures-macro v0.3.28 [INFO] [stderr] Compiling enum-iterator v1.4.1 [INFO] [stderr] Compiling tracing-attributes v0.1.26 [INFO] [stderr] Compiling pin-project-internal v1.1.3 [INFO] [stderr] Compiling clap_derive v3.2.25 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling pin-project v1.1.3 [INFO] [stderr] Compiling bytes v1.5.0 [INFO] [stderr] Compiling tokio v1.32.0 [INFO] [stderr] Compiling http v0.2.9 [INFO] [stderr] Compiling toml v0.5.11 [INFO] [stderr] Compiling tungstenite v0.20.1 [INFO] [stderr] Compiling clap v3.2.25 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling tokio-tungstenite v0.20.1 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tokio-util v0.7.9 [INFO] [stderr] Compiling async-http-proxy v1.2.5 [INFO] [stderr] Compiling snowstorm v0.4.0 [INFO] [stderr] Compiling async-socks5 v0.5.1 [INFO] [stderr] Compiling git2 v0.16.1 [INFO] [stderr] Compiling rathole v0.5.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: the item `Result` is imported redundantly [INFO] [stdout] --> src/transport/websocket.rs:1:5 [INFO] [stdout] | [INFO] [stdout] 1 | use core::result::Result; [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stdout] | [INFO] [stdout] = note: the item `Result` is already defined here [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 12s [INFO] running `Command { std: "docker" "inspect" "183d432e2a1c30a1eda6b4b7c92a2e931f8cd328c23215b4512b4453343ad183", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "183d432e2a1c30a1eda6b4b7c92a2e931f8cd328c23215b4512b4453343ad183", kill_on_drop: false }` [INFO] [stdout] 183d432e2a1c30a1eda6b4b7c92a2e931f8cd328c23215b4512b4453343ad183 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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=forbid -Copt-level=3" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+61223975d46f794466efa832bc7562b9707ecc46" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 46aaa57ac273cc5a1abf81301e334309d8cc1db55a3a6bf89c888da396d0309b [INFO] running `Command { std: "docker" "start" "-a" "46aaa57ac273cc5a1abf81301e334309d8cc1db55a3a6bf89c888da396d0309b", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.148 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling subtle v2.5.0 [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling cpufeatures v0.2.9 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling smallvec v1.11.1 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling percent-encoding v2.3.0 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling unicode-bidi v0.3.13 [INFO] [stderr] Compiling form_urlencoded v1.2.0 [INFO] [stderr] Compiling thiserror v1.0.49 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling zeroize v1.6.0 [INFO] [stderr] Compiling lock_api v0.4.10 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling once_cell v1.18.0 [INFO] [stderr] Compiling jobserver v0.1.26 [INFO] [stderr] Compiling getrandom v0.2.10 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling parking_lot_core v0.9.8 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling unicode-normalization v0.1.22 [INFO] [stderr] Compiling mio v0.8.8 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling inout v0.1.3 [INFO] [stderr] Compiling idna v0.4.0 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling socket2 v0.5.4 [INFO] [stderr] Compiling signal-hook-registry v1.4.1 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling time v0.3.29 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling cipher v0.4.4 [INFO] [stderr] Compiling universal-hash v0.5.1 [INFO] [stderr] Compiling bytes v1.5.0 [INFO] [stderr] Compiling anyhow v1.0.75 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling url v2.4.1 [INFO] [stderr] Compiling futures-core v0.3.28 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling tokio v1.32.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling polyval v0.6.1 [INFO] [stderr] Compiling aead v0.5.2 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling futures-sink v0.3.28 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling ghash v0.5.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling poly1305 v0.8.0 [INFO] [stderr] Compiling ctr v0.9.2 [INFO] [stderr] Compiling chacha20 v0.9.1 [INFO] [stderr] Compiling aes v0.8.4 [INFO] [stderr] Compiling tracing-core v0.1.31 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling futures-task v0.3.28 [INFO] [stderr] Compiling httparse v1.8.0 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling bitflags v2.4.0 [INFO] [stderr] Compiling regex-syntax v0.7.5 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-util v0.3.28 [INFO] [stderr] Compiling http v0.2.9 [INFO] [stderr] Compiling openssl-sys v0.9.93 [INFO] [stderr] Compiling libz-sys v1.1.12 [INFO] [stderr] Compiling libgit2-sys v0.14.2+1.5.1 [INFO] [stderr] Compiling vergen v7.5.1 [INFO] [stderr] Compiling regex-automata v0.3.9 [INFO] [stderr] Compiling openssl v0.10.57 [INFO] [stderr] Compiling native-tls v0.2.11 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling aes-gcm v0.10.3 [INFO] [stderr] Compiling chacha20poly1305 v0.10.1 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling blake2 v0.10.6 [INFO] [stderr] Compiling curve25519-dalek v4.1.2 [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling os_str_bytes v6.5.1 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling data-encoding v2.4.0 [INFO] [stderr] Compiling utf-8 v0.7.6 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling walkdir v2.4.0 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling tungstenite v0.20.1 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling inotify v0.9.6 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling snow v0.9.6 [INFO] [stderr] Compiling regex v1.9.6 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tracing-log v0.1.3 [INFO] [stderr] Compiling sharded-slab v0.1.6 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling pin-project v1.1.3 [INFO] [stderr] Compiling thread_local v1.1.7 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling filetime v0.2.22 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling termcolor v1.3.0 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling textwrap v0.16.0 [INFO] [stderr] Compiling async-http-proxy v1.2.5 [INFO] [stderr] Compiling notify v5.2.0 [INFO] [stderr] Compiling clap v3.2.25 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling snowstorm v0.4.0 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tokio-tungstenite v0.20.1 [INFO] [stderr] Compiling async-socks5 v0.5.1 [INFO] [stderr] Compiling tokio-util v0.7.9 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling toml v0.5.11 [INFO] [stderr] Compiling socket2 v0.4.9 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling git2 v0.16.1 [INFO] [stderr] Compiling rathole v0.5.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: the item `Result` is imported redundantly [INFO] [stdout] --> src/transport/websocket.rs:1:5 [INFO] [stdout] | [INFO] [stdout] 1 | use core::result::Result; [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stdout] | [INFO] [stdout] = note: the item `Result` is already defined here [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: the item `Result` is imported redundantly [INFO] [stdout] --> src/config.rs:341:9 [INFO] [stdout] | [INFO] [stdout] 338 | use super::*; [INFO] [stdout] | -------- the item `Result` is already imported here [INFO] [stdout] ... [INFO] [stdout] 341 | use anyhow::Result; [INFO] [stdout] | ^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: the item `ServerConfig` is imported redundantly [INFO] [stdout] --> src/config_watcher.rs:265:9 [INFO] [stdout] | [INFO] [stdout] 265 | use crate::config::ServerConfig; [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] 266 | [INFO] [stdout] 267 | use super::*; [INFO] [stdout] | -------- the item `ServerConfig` is already imported here [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: the item `Result` is imported redundantly [INFO] [stdout] --> src/transport/websocket.rs:1:5 [INFO] [stdout] | [INFO] [stdout] 1 | use core::result::Result; [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stdout] | [INFO] [stdout] = note: the item `Result` is already defined here [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: the item `Result` is imported redundantly [INFO] [stdout] --> src/transport/websocket.rs:1:5 [INFO] [stdout] | [INFO] [stdout] 1 | use core::result::Result; [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stdout] | [INFO] [stdout] = note: the item `Result` is already defined here [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 3 warnings emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 55s [INFO] running `Command { std: "docker" "inspect" "46aaa57ac273cc5a1abf81301e334309d8cc1db55a3a6bf89c888da396d0309b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "46aaa57ac273cc5a1abf81301e334309d8cc1db55a3a6bf89c888da396d0309b", kill_on_drop: false }` [INFO] [stdout] 46aaa57ac273cc5a1abf81301e334309d8cc1db55a3a6bf89c888da396d0309b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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=forbid -Copt-level=3" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+61223975d46f794466efa832bc7562b9707ecc46" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 6453b361f8db81ea594105e9260d439e39504f43166ff87e2d0a48706366774e [INFO] running `Command { std: "docker" "start" "-a" "6453b361f8db81ea594105e9260d439e39504f43166ff87e2d0a48706366774e", kill_on_drop: false }` [INFO] [stderr] warning: the item `Result` is imported redundantly [INFO] [stderr] --> src/transport/websocket.rs:1:5 [INFO] [stderr] | [INFO] [stderr] 1 | use core::result::Result; [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stderr] | [INFO] [stderr] = note: the item `Result` is already defined here [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_imports)]` on by default [INFO] [stderr] [INFO] [stderr] warning: `rathole` (lib) generated 1 warning [INFO] [stderr] warning: the item `Result` is imported redundantly [INFO] [stderr] --> src/config.rs:341:9 [INFO] [stderr] | [INFO] [stderr] 338 | use super::*; [INFO] [stderr] | -------- the item `Result` is already imported here [INFO] [stderr] ... [INFO] [stderr] 341 | use anyhow::Result; [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_imports)]` on by default [INFO] [stderr] [INFO] [stderr] warning: the item `ServerConfig` is imported redundantly [INFO] [stderr] --> src/config_watcher.rs:265:9 [INFO] [stderr] | [INFO] [stderr] 265 | use crate::config::ServerConfig; [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] 266 | [INFO] [stderr] 267 | use super::*; [INFO] [stderr] | -------- the item `ServerConfig` is already imported here [INFO] [stderr] [INFO] [stderr] warning: the item `Result` is imported redundantly [INFO] [stderr] --> src/transport/websocket.rs:1:5 [INFO] [stderr] | [INFO] [stderr] 1 | use core::result::Result; [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] --> /rustc/61223975d46f794466efa832bc7562b9707ecc46/library/std/src/prelude/mod.rs:129:13 [INFO] [stderr] | [INFO] [stderr] = note: the item `Result` is already defined here [INFO] [stderr] [INFO] [stderr] warning: `rathole` (lib test) generated 3 warnings [INFO] [stderr] warning: `rathole` (lib) generated 1 warning (1 duplicate) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rathole-9b493c7ad35c902f) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test config::tests::test_valid_config ... ok [INFO] [stdout] test config::tests::test_example_config ... ok [INFO] [stdout] test config_watcher::test::test_calculate_events ... ok [INFO] [stdout] test config::tests::test_validate_client_config ... ok [INFO] [stdout] test tests::test_determine_run_mode ... ok [INFO] [stdout] test config::tests::test_validate_server_config ... ok [INFO] [stdout] test config::tests::test_invalid_config ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rathole-f005e2558fe2944e) [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/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-b19a8bfa60f56e80) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] 2024-03-01T09:59:54.390807Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] 2024-03-01T09:59:54.390843Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] 2024-03-01T09:59:54.391347Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:54.391375Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T09:59:54.391379Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:54.391392Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T09:59:54.391399Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T09:59:54.391412Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T09:59:54.391619Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 499.211194ms... [INFO] [stdout] 2024-03-01T09:59:54.391637Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 518.477957ms... [INFO] [stdout] 2024-03-01T09:59:54.391677Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 504.04678ms... [INFO] [stdout] 2024-03-01T09:59:54.391705Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 479.804987ms... [INFO] [stdout] 2024-03-01T09:59:54.872312Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 965.662911ms... [INFO] [stdout] 2024-03-01T09:59:54.891277Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.013648136s... [INFO] [stdout] 2024-03-01T09:59:54.896412Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.196096933s... [INFO] [stdout] 2024-03-01T09:59:54.911506Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 911.867825ms... [INFO] [stdout] 2024-03-01T09:59:55.390969Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] 2024-03-01T09:59:55.391049Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] 2024-03-01T09:59:55.391285Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:55.391321Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T09:59:55.391385Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:55.391420Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T09:59:55.824033Z  INFO connection{addr=127.0.0.1:36382}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:55.824078Z  INFO connection{addr=127.0.0.1:36382}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:55.824190Z  INFO connection{addr=127.0.0.1:36382}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:55.824211Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:55.839912Z  INFO connection{addr=127.0.0.1:36462}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:55.839951Z  INFO connection{addr=127.0.0.1:36462}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:55.840043Z  INFO connection{addr=127.0.0.1:36462}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:55.840058Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:55.906981Z  INFO connection{addr=127.0.0.1:47728}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:55.907022Z  INFO connection{addr=127.0.0.1:47728}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:55.907063Z  INFO connection{addr=127.0.0.1:47728}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:55.907091Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:56.093636Z  INFO connection{addr=127.0.0.1:47764}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:56.093675Z  INFO connection{addr=127.0.0.1:47764}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:56.093714Z  INFO connection{addr=127.0.0.1:47764}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:56.093740Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:57.892308Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T09:59:57.892819Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T09:59:57.893197Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T09:59:57.893527Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T09:59:57.893539Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T09:59:57.893571Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.893599Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.893629Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T09:59:57.893876Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:57.893890Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T09:59:57.893896Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T09:59:57.894117Z  INFO connection{addr=127.0.0.1:47790}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:57.894141Z  INFO connection{addr=127.0.0.1:47798}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:57.894193Z  WARN connection{addr=127.0.0.1:47790}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T09:59:57.894206Z  INFO connection{addr=127.0.0.1:47790}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:57.894245Z  WARN connection{addr=127.0.0.1:47798}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T09:59:57.894266Z  INFO connection{addr=127.0.0.1:47798}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:57.894332Z  INFO connection{addr=127.0.0.1:47764}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.894387Z  INFO connection{addr=127.0.0.1:47790}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:57.894459Z  INFO connection{addr=127.0.0.1:47728}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.894514Z  INFO connection{addr=127.0.0.1:47798}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:57.894553Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:57.894578Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:57.894621Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T09:59:57.894675Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.894712Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T09:59:57.894757Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.897976Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T09:59:57.903003Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T09:59:57.903014Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T09:59:57.903035Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.903058Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.903082Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T09:59:57.903320Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:57.903333Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T09:59:57.903340Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T09:59:57.903589Z  INFO connection{addr=127.0.0.1:36572}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:57.903612Z  INFO connection{addr=127.0.0.1:36586}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:57.903658Z  WARN connection{addr=127.0.0.1:36572}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T09:59:57.903676Z  INFO connection{addr=127.0.0.1:36572}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:57.903698Z  WARN connection{addr=127.0.0.1:36586}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T09:59:57.903717Z  INFO connection{addr=127.0.0.1:36586}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:57.903730Z  INFO connection{addr=127.0.0.1:36382}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.903765Z  INFO connection{addr=127.0.0.1:36382}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T09:59:57.903846Z  INFO connection{addr=127.0.0.1:36462}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:57.903907Z  INFO connection{addr=127.0.0.1:36462}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T09:59:57.903996Z  INFO connection{addr=127.0.0.1:36382}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:57.904111Z  INFO connection{addr=127.0.0.1:36572}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:57.904124Z  INFO connection{addr=127.0.0.1:36462}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:57.904235Z  INFO connection{addr=127.0.0.1:36586}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:57.904258Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:57.904300Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:57.904388Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904442Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904495Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904546Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904598Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904648Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904704Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904752Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904806Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904859Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904917Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.904969Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.905012Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.905062Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.905113Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:57.905164Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.894175Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T09:59:58.894545Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T09:59:58.894887Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T09:59:58.894899Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T09:59:58.894918Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T09:59:58.894925Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:58.894976Z  INFO connection{addr=127.0.0.1:47798}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:58.895020Z  INFO connection{addr=127.0.0.1:47790}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:58.895050Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T09:59:58.895089Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T09:59:58.895144Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.895205Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 417.056981ms... [INFO] [stdout] 2024-03-01T09:59:58.895242Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T09:59:58.895292Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.895346Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 587.642484ms... [INFO] [stdout] 2024-03-01T09:59:58.895573Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:58.895601Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T09:59:58.904063Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T09:59:58.908872Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T09:59:58.913819Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T09:59:58.913830Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T09:59:58.913844Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T09:59:58.913847Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:58.913864Z  INFO connection{addr=127.0.0.1:36586}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:58.913893Z  INFO connection{addr=127.0.0.1:36586}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T09:59:58.913913Z  INFO connection{addr=127.0.0.1:36572}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T09:59:58.913935Z  INFO connection{addr=127.0.0.1:36572}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T09:59:58.913949Z  INFO connection{addr=127.0.0.1:36586}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:58.914089Z  INFO connection{addr=127.0.0.1:36572}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T09:59:58.914187Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T09:59:58.914257Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 545.249562ms... [INFO] [stdout] 2024-03-01T09:59:58.914317Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 589.12609ms... [INFO] [stdout] 2024-03-01T09:59:58.914366Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914406Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914448Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914493Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914545Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914595Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914641Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914692Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914754Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914805Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914863Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914917Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.914971Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.915020Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.915072Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.915114Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T09:59:58.915338Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T09:59:58.915366Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T09:59:59.313157Z  INFO connection{addr=127.0.0.1:47838}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:59.313199Z  INFO connection{addr=127.0.0.1:47838}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:59.313246Z  INFO connection{addr=127.0.0.1:47838}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:59.313286Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:59.460802Z  INFO connection{addr=127.0.0.1:36730}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:59.460853Z  INFO connection{addr=127.0.0.1:36730}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:59.460928Z  INFO connection{addr=127.0.0.1:36730}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:59.460946Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:59.484798Z  INFO connection{addr=127.0.0.1:47854}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:59.484838Z  INFO connection{addr=127.0.0.1:47854}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T09:59:59.484880Z  INFO connection{addr=127.0.0.1:47854}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T09:59:59.484913Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T09:59:59.504592Z  INFO connection{addr=127.0.0.1:36826}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T09:59:59.504643Z  INFO connection{addr=127.0.0.1:36826}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T09:59:59.504721Z  INFO connection{addr=127.0.0.1:36826}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T09:59:59.504741Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:01.396111Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:01.397348Z  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:01.397364Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:01.397381Z  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:01.397406Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:01.397415Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:01.397492Z  INFO connection{addr=127.0.0.1:47838}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.397564Z  INFO connection{addr=127.0.0.1:47854}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.397596Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.397667Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.397738Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:01.397794Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:01.397852Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.397889Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:01.397944Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.398297Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:01.415151Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:01.431946Z  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:01.431997Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:01.432020Z  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:01.432048Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:01.432055Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:01.432083Z  INFO connection{addr=127.0.0.1:36730}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.432110Z  INFO connection{addr=127.0.0.1:36730}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:01.432131Z  INFO connection{addr=127.0.0.1:36826}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.432158Z  INFO connection{addr=127.0.0.1:36826}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:01.432179Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.432219Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:01.432258Z  INFO connection{addr=127.0.0.1:36730}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:01.432360Z  INFO connection{addr=127.0.0.1:36826}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:01.432485Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:01.432588Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432645Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432706Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432791Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432864Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432922Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.432970Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433015Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433058Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433105Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433153Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433203Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433262Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433316Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433373Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433428Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:01.433759Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:01.467721Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:01.467736Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:01.467842Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 403.837691ms... [INFO] [stdout] 2024-03-01T10:00:01.467885Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 533.410181ms... [INFO] [stdout] 2024-03-01T10:00:01.490283Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:01.490297Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:01.490502Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 444.214636ms... [INFO] [stdout] 2024-03-01T10:00:01.490548Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 432.001152ms... [INFO] [stdout] 2024-03-01T10:00:01.872490Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.124231347s... [INFO] [stdout] 2024-03-01T10:00:01.923260Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 992.605049ms... [INFO] [stdout] 2024-03-01T10:00:01.935411Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 824.990122ms... [INFO] [stdout] 2024-03-01T10:00:02.002757Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 849.940635ms... [INFO] [stdout] 2024-03-01T10:00:02.398256Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:02.398597Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:02.432980Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:02.433250Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:02.440644Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:02.474355Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:02.765333Z  INFO connection{addr=127.0.0.1:36990}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:02.765413Z  INFO connection{addr=127.0.0.1:36990}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:02.765529Z  INFO connection{addr=127.0.0.1:36990}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:02.765555Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:02.855418Z  INFO connection{addr=127.0.0.1:47936}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:02.855470Z  INFO connection{addr=127.0.0.1:47936}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:02.855507Z  INFO connection{addr=127.0.0.1:47936}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:02.855561Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:02.918952Z  INFO connection{addr=127.0.0.1:37060}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:02.919003Z  INFO connection{addr=127.0.0.1:37060}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:02.919095Z  INFO connection{addr=127.0.0.1:37060}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:02.919117Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:02.999269Z  INFO connection{addr=127.0.0.1:47954}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:02.999320Z  INFO connection{addr=127.0.0.1:47954}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:02.999354Z  INFO connection{addr=127.0.0.1:47954}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:02.999404Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:04.899093Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:04.899577Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:04.900003Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:04.900018Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:04.900057Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.900154Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.900216Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:04.900492Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:04.933495Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:04.933510Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:04.934282Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:04.936594Z  INFO connection{addr=127.0.0.1:47976}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:04.937544Z  WARN connection{addr=127.0.0.1:47976}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:04.937564Z  INFO connection{addr=127.0.0.1:47976}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:04.937675Z  INFO connection{addr=127.0.0.1:47936}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.937738Z  INFO connection{addr=127.0.0.1:47976}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:04.937798Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:04.937846Z  INFO connection{addr=127.0.0.1:47992}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:04.937915Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:04.937999Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.938445Z  WARN connection{addr=127.0.0.1:47992}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:04.938475Z  INFO connection{addr=127.0.0.1:47992}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:04.939291Z  INFO connection{addr=127.0.0.1:47954}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.939350Z  INFO connection{addr=127.0.0.1:47992}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:04.939406Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:04.940255Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:04.940328Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.943098Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:04.951182Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:04.951195Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:04.951222Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.951280Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.951337Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:04.951593Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:04.984304Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:04.984322Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:04.987307Z  INFO connection{addr=127.0.0.1:37162}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:04.988268Z  WARN connection{addr=127.0.0.1:37162}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:04.988294Z  INFO connection{addr=127.0.0.1:37162}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:04.988372Z  INFO connection{addr=127.0.0.1:36990}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.988424Z  INFO connection{addr=127.0.0.1:36990}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:04.988531Z  INFO connection{addr=127.0.0.1:36990}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:04.988675Z  INFO connection{addr=127.0.0.1:37162}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:04.988716Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:04.988795Z  INFO connection{addr=127.0.0.1:37168}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:04.988891Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.988978Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989055Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989138Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989223Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989304Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989382Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.989480Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.990623Z  WARN connection{addr=127.0.0.1:37168}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:04.990643Z  INFO connection{addr=127.0.0.1:37168}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:04.991424Z  INFO connection{addr=127.0.0.1:37060}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:04.991463Z  INFO connection{addr=127.0.0.1:37060}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:04.991567Z  INFO connection{addr=127.0.0.1:37060}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:04.991727Z  INFO connection{addr=127.0.0.1:37168}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:04.991755Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:04.992603Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.992666Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.992742Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.992820Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.992877Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.992950Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.993010Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:04.993667Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.901166Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:05.901669Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:05.902149Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:05.902161Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:05.902180Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:05.902184Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:05.903078Z  INFO connection{addr=127.0.0.1:47992}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:05.903125Z  INFO connection{addr=127.0.0.1:47976}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:05.903170Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:05.903230Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:05.903307Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.903393Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 550.972762ms... [INFO] [stdout] 2024-03-01T10:00:05.903436Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:05.903512Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.903603Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 541.780766ms... [INFO] [stdout] 2024-03-01T10:00:05.903855Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:05.939775Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:05.952788Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:05.960762Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:05.968562Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:05.968575Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:05.968591Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:05.968597Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:05.969220Z  INFO connection{addr=127.0.0.1:37162}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:05.969252Z  INFO connection{addr=127.0.0.1:37162}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:05.969266Z  INFO connection{addr=127.0.0.1:37168}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:05.969289Z  INFO connection{addr=127.0.0.1:37168}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:05.969310Z  INFO connection{addr=127.0.0.1:37162}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:05.969445Z  INFO connection{addr=127.0.0.1:37168}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:05.969578Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:05.969902Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 467.987208ms... [INFO] [stdout] 2024-03-01T10:00:05.969971Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 486.421281ms... [INFO] [stdout] 2024-03-01T10:00:05.970056Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970139Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970226Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970313Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970403Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970491Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970575Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970659Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970749Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970826Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970905Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.970982Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.971065Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.971154Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.971233Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.971311Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:05.971558Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:06.007393Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:06.441181Z  INFO connection{addr=127.0.0.1:42470}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:06.441251Z  INFO connection{addr=127.0.0.1:42470}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:06.441350Z  INFO connection{addr=127.0.0.1:42470}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:06.441373Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:06.448594Z  INFO connection{addr=127.0.0.1:49272}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:06.448673Z  INFO connection{addr=127.0.0.1:49272}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:06.448714Z  INFO connection{addr=127.0.0.1:49272}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:06.448762Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:06.458468Z  INFO connection{addr=127.0.0.1:49288}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:06.458545Z  INFO connection{addr=127.0.0.1:49288}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:06.458579Z  INFO connection{addr=127.0.0.1:49288}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:06.458629Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:06.460190Z  INFO connection{addr=127.0.0.1:42532}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:06.460243Z  INFO connection{addr=127.0.0.1:42532}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:06.460352Z  INFO connection{addr=127.0.0.1:42532}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:06.460376Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:08.404780Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:08.406013Z  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:08.406042Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:08.406056Z  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:08.406074Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:08.406078Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:08.406725Z  INFO connection{addr=127.0.0.1:49272}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.406786Z  INFO connection{addr=127.0.0.1:49288}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.406845Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.406903Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.406973Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:08.407027Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:08.407109Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.407151Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:08.407220Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.407493Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:08.407554Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:08.407566Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:08.407657Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Failed to connect TCP socket: Connection refused (os error 111). Retry in 516.659742ms... [INFO] [stdout] 2024-03-01T10:00:08.407703Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Failed to connect TCP socket: Connection refused (os error 111). Retry in 561.863562ms... [INFO] [stdout] 2024-03-01T10:00:08.471856Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:08.500443Z  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:08.500490Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:08.500509Z  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:08.500534Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:08.500539Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:08.501074Z  INFO connection{addr=127.0.0.1:42470}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.501106Z  INFO connection{addr=127.0.0.1:42470}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:08.501121Z  INFO connection{addr=127.0.0.1:42532}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.501137Z  INFO connection{addr=127.0.0.1:42532}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:08.501370Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.501437Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:08.501495Z  INFO connection{addr=127.0.0.1:42470}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:08.501629Z  INFO connection{addr=127.0.0.1:42532}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:08.501774Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:08.501936Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502013Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502103Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502181Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502265Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502352Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502434Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502525Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502610Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502688Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502777Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502862Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.502937Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.503022Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.503095Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.503172Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:08.503464Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:08.503498Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:08.503507Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:08.504161Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Failed to connect TCP socket: Connection refused (os error 111). Retry in 561.075095ms... [INFO] [stdout] 2024-03-01T10:00:08.504373Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Failed to connect TCP socket: Connection refused (os error 111). Retry in 586.17749ms... [INFO] [stdout] 2024-03-01T10:00:08.925376Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Failed to connect TCP socket: Connection refused (os error 111). Retry in 1.190585048s... [INFO] [stdout] 2024-03-01T10:00:08.970516Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Failed to connect TCP socket: Connection refused (os error 111). Retry in 1.014517426s... [INFO] [stdout] 2024-03-01T10:00:09.066332Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Failed to connect TCP socket: Connection refused (os error 111). Retry in 973.508875ms... [INFO] [stdout] 2024-03-01T10:00:09.091463Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Failed to connect TCP socket: Connection refused (os error 111). Retry in 930.536344ms... [INFO] [stdout] 2024-03-01T10:00:09.408013Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:09.408251Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:09.408290Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:09.501960Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:09.502214Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:09.502260Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:09.987553Z  INFO connection{addr=127.0.0.1:49350}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:09.987604Z  INFO connection{addr=127.0.0.1:49350}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:09.987633Z  INFO connection{addr=127.0.0.1:49350}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:09.987665Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:10.024339Z  INFO connection{addr=127.0.0.1:42702}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:10.024387Z  INFO connection{addr=127.0.0.1:42702}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:10.024471Z  INFO connection{addr=127.0.0.1:42702}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:10.024490Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:10.041806Z  INFO connection{addr=127.0.0.1:42786}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:10.041854Z  INFO connection{addr=127.0.0.1:42786}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:10.041933Z  INFO connection{addr=127.0.0.1:42786}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:10.041949Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:10.117692Z  INFO connection{addr=127.0.0.1:49378}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:10.117746Z  INFO connection{addr=127.0.0.1:49378}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:10.117773Z  INFO connection{addr=127.0.0.1:49378}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:10.117803Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:11.908993Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:11.909483Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:11.909945Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:11.909958Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:11.909981Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:11.910003Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:11.910022Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:11.910305Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:11.910360Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:11.910374Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:11.911433Z  INFO connection{addr=127.0.0.1:49406}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:11.911561Z  INFO connection{addr=127.0.0.1:49416}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:11.911587Z  WARN connection{addr=127.0.0.1:49406}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:11.911602Z  INFO connection{addr=127.0.0.1:49406}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:11.911673Z  INFO connection{addr=127.0.0.1:49350}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:11.911731Z  INFO connection{addr=127.0.0.1:49406}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:11.911773Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:11.911814Z  WARN connection{addr=127.0.0.1:49416}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:11.911838Z  INFO connection{addr=127.0.0.1:49416}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:11.911882Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:11.911941Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:11.912068Z  INFO connection{addr=127.0.0.1:49378}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:11.912127Z  INFO connection{addr=127.0.0.1:49416}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:11.912186Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:11.912681Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:11.912727Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.003687Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:12.010268Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:12.016393Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:12.016405Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:12.016426Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.016452Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.016485Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:12.016728Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:12.016762Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:12.016771Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:12.017772Z  INFO connection{addr=127.0.0.1:42900}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:12.017910Z  INFO connection{addr=127.0.0.1:42908}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:12.017944Z  WARN connection{addr=127.0.0.1:42900}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:12.017959Z  INFO connection{addr=127.0.0.1:42900}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:12.017997Z  INFO connection{addr=127.0.0.1:42786}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.018062Z  INFO connection{addr=127.0.0.1:42786}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:12.018169Z  INFO connection{addr=127.0.0.1:42786}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:12.018281Z  INFO connection{addr=127.0.0.1:42900}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:12.018305Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:12.018383Z  WARN connection{addr=127.0.0.1:42908}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:12.018408Z  INFO connection{addr=127.0.0.1:42908}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:12.018472Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018523Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018580Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018631Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018689Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018752Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018806Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.018861Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.019118Z  INFO connection{addr=127.0.0.1:42702}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.019159Z  INFO connection{addr=127.0.0.1:42702}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:12.019257Z  INFO connection{addr=127.0.0.1:42702}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:12.019499Z  INFO connection{addr=127.0.0.1:42908}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:12.019530Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:12.020805Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.020855Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.020898Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.020949Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.021001Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.021057Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.021112Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.021242Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.911468Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:12.911862Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:12.912217Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:12.912228Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:12.912248Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:12.912256Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:12.912313Z  INFO connection{addr=127.0.0.1:49416}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.912361Z  INFO connection{addr=127.0.0.1:49406}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:12.912383Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:12.912417Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:12.912470Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.912532Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 520.852529ms... [INFO] [stdout] 2024-03-01T10:00:12.912580Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:12.912635Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:12.912694Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 533.429385ms... [INFO] [stdout] 2024-03-01T10:00:12.912957Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:12.912989Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:13.017416Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:13.024096Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:13.030293Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:13.030307Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:13.030327Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:13.030330Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:13.030354Z  INFO connection{addr=127.0.0.1:42900}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:13.030385Z  INFO connection{addr=127.0.0.1:42900}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:13.030406Z  INFO connection{addr=127.0.0.1:42908}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:13.030432Z  INFO connection{addr=127.0.0.1:42908}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:13.030450Z  INFO connection{addr=127.0.0.1:42900}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:13.030551Z  INFO connection{addr=127.0.0.1:42908}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:13.030659Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:13.030748Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 439.184748ms... [INFO] [stdout] 2024-03-01T10:00:13.030812Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 401.954749ms... [INFO] [stdout] 2024-03-01T10:00:13.030863Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.030912Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.030958Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.030996Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031037Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031082Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031132Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031235Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031293Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031344Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031393Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031446Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031500Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031553Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031726Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.031789Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:13.032044Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:13.032086Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:13.434406Z  INFO connection{addr=127.0.0.1:43094}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:13.434455Z  INFO connection{addr=127.0.0.1:43094}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:13.434535Z  INFO connection{addr=127.0.0.1:43094}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:13.434547Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:13.435166Z  INFO connection{addr=127.0.0.1:49434}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:13.435218Z  INFO connection{addr=127.0.0.1:49434}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:13.435255Z  INFO connection{addr=127.0.0.1:49434}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:13.435304Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:13.447907Z  INFO connection{addr=127.0.0.1:49458}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:13.447958Z  INFO connection{addr=127.0.0.1:49458}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:13.447992Z  INFO connection{addr=127.0.0.1:49458}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:13.448040Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:13.472124Z  INFO connection{addr=127.0.0.1:43186}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:13.472184Z  INFO connection{addr=127.0.0.1:43186}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:13.472291Z  INFO connection{addr=127.0.0.1:43186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:13.472308Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:15.413266Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:15.414621Z  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:15.414635Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:15.414652Z  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:15.414680Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:15.414688Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:15.414770Z  INFO connection{addr=127.0.0.1:49458}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.414821Z  INFO connection{addr=127.0.0.1:49434}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.414852Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.414897Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.414951Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:15.414998Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:15.415047Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.415082Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] 2024-03-01T10:00:15.415134Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.415382Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:15.415396Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:15.415403Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:15.415529Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 440.667745ms... [INFO] [stdout] 2024-03-01T10:00:15.415570Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 444.54365ms... [INFO] [stdout] 2024-03-01T10:00:15.531172Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:15.571218Z  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:15.571255Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:15.571270Z  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:15.571291Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:15.571298Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:15.571324Z  INFO connection{addr=127.0.0.1:43094}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.571361Z  INFO connection{addr=127.0.0.1:43094}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:15.571385Z  INFO connection{addr=127.0.0.1:43186}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.571421Z  INFO connection{addr=127.0.0.1:43186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:15.571447Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.571496Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:15.571533Z  INFO connection{addr=127.0.0.1:43094}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:15.571628Z  INFO connection{addr=127.0.0.1:43186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:15.571750Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:15.571863Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.571920Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.571978Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572028Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572084Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572138Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572192Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572250Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572309Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572367Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572419Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572473Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572521Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572569Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572620Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.572852Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] 2024-03-01T10:00:15.573161Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:15.573174Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:15.573182Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:15.573392Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 455.583523ms... [INFO] [stdout] 2024-03-01T10:00:15.573430Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 543.960161ms... [INFO] [stdout] 2024-03-01T10:00:15.857156Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.130607779s... [INFO] [stdout] 2024-03-01T10:00:15.861301Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 889.935771ms... [INFO] [stdout] 2024-03-01T10:00:16.030439Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 1.150219012s... [INFO] [stdout] 2024-03-01T10:00:16.118647Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 998.739171ms... [INFO] [stdout] 2024-03-01T10:00:16.415943Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:16.416161Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:16.416200Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:16.572161Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:16.572464Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:16.572507Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:16.752776Z  INFO connection{addr=127.0.0.1:49334}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:16.752830Z  INFO connection{addr=127.0.0.1:49334}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:16.752868Z  INFO connection{addr=127.0.0.1:49334}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:16.752916Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:16.988684Z  INFO connection{addr=127.0.0.1:49350}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:16.988746Z  INFO connection{addr=127.0.0.1:49350}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:16.988782Z  INFO connection{addr=127.0.0.1:49350}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:16.988824Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:17.118287Z  INFO connection{addr=127.0.0.1:58540}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:17.118339Z  INFO connection{addr=127.0.0.1:58540}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:17.118422Z  INFO connection{addr=127.0.0.1:58540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:17.118453Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:17.181533Z  INFO connection{addr=127.0.0.1:58622}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:17.181573Z  INFO connection{addr=127.0.0.1:58622}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:17.181664Z  INFO connection{addr=127.0.0.1:58622}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:17.181696Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:18.917190Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:18.917674Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:18.918093Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:18.918111Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:18.918155Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:18.918196Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:18.918238Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:18.918568Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:18.918587Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:18.918596Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:18.918961Z  INFO connection{addr=127.0.0.1:49376}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:18.919030Z  INFO connection{addr=127.0.0.1:49392}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:18.919074Z  WARN connection{addr=127.0.0.1:49376}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:18.919093Z  INFO connection{addr=127.0.0.1:49376}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:18.919182Z  INFO connection{addr=127.0.0.1:49334}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:18.919251Z  INFO connection{addr=127.0.0.1:49376}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:18.919303Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:18.919329Z  WARN connection{addr=127.0.0.1:49392}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:18.919350Z  INFO connection{addr=127.0.0.1:49392}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:18.919412Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:18.919475Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:18.919617Z  INFO connection{addr=127.0.0.1:49350}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:18.919680Z  INFO connection{addr=127.0.0.1:49392}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:18.919735Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:18.919862Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:18.919921Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.073502Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:19.078734Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:19.083765Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:19.083780Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:19.083812Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.083846Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.083882Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:19.084325Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:19.084342Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:19.084350Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:19.084640Z  INFO connection{addr=127.0.0.1:58724}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:19.084688Z  INFO connection{addr=127.0.0.1:58728}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:19.084710Z  WARN connection{addr=127.0.0.1:58724}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:19.084722Z  INFO connection{addr=127.0.0.1:58724}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:19.084744Z  INFO connection{addr=127.0.0.1:58540}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.084782Z  INFO connection{addr=127.0.0.1:58540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:19.084860Z  INFO connection{addr=127.0.0.1:58540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:19.084987Z  INFO connection{addr=127.0.0.1:58724}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:19.085029Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:19.085061Z  WARN connection{addr=127.0.0.1:58728}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:19.085083Z  INFO connection{addr=127.0.0.1:58728}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:19.085149Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085209Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085273Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085336Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085394Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085451Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085509Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085566Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.085886Z  INFO connection{addr=127.0.0.1:58622}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.085929Z  INFO connection{addr=127.0.0.1:58622}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:19.086018Z  INFO connection{addr=127.0.0.1:58622}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:19.086159Z  INFO connection{addr=127.0.0.1:58728}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:19.086199Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:19.086473Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086517Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086571Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086613Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086663Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086713Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086764Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.086810Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.919452Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:19.919968Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:19.920357Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:19.920373Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:19.920405Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:19.920414Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:19.920489Z  INFO connection{addr=127.0.0.1:49392}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.920556Z  INFO connection{addr=127.0.0.1:49376}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:19.920593Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:19.920651Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.920713Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.920771Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 576.567671ms... [INFO] [stdout] 2024-03-01T10:00:19.920803Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.920848Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:19.920903Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 446.783038ms... [INFO] [stdout] 2024-03-01T10:00:19.921287Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:19.921334Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:20.085155Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:20.090486Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:20.095530Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:20.095549Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:20.095574Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:20.095576Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:20.095597Z  INFO connection{addr=127.0.0.1:58728}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:20.095625Z  INFO connection{addr=127.0.0.1:58728}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:20.095648Z  INFO connection{addr=127.0.0.1:58724}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:20.095681Z  INFO connection{addr=127.0.0.1:58724}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:20.095698Z  INFO connection{addr=127.0.0.1:58728}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:20.095821Z  INFO connection{addr=127.0.0.1:58724}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:20.095954Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:20.096056Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 583.213964ms... [INFO] [stdout] 2024-03-01T10:00:20.096121Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 513.059877ms... [INFO] [stdout] 2024-03-01T10:00:20.096180Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096237Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096290Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096335Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096386Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096437Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096484Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096540Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096603Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096657Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096710Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096761Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096818Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096871Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096917Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.096974Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:20.097402Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:20.097461Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:20.369106Z  INFO connection{addr=127.0.0.1:49450}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:20.369157Z  INFO connection{addr=127.0.0.1:49450}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:20.369189Z  INFO connection{addr=127.0.0.1:49450}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:20.369230Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:20.499070Z  INFO connection{addr=127.0.0.1:49486}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:20.499117Z  INFO connection{addr=127.0.0.1:49486}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:20.499154Z  INFO connection{addr=127.0.0.1:49486}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:20.499204Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:20.610211Z  INFO connection{addr=127.0.0.1:58914}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:20.610271Z  INFO connection{addr=127.0.0.1:58914}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:20.610367Z  INFO connection{addr=127.0.0.1:58914}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:20.610398Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:20.680488Z  INFO connection{addr=127.0.0.1:59030}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:20.680547Z  INFO connection{addr=127.0.0.1:59030}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:20.680632Z  INFO connection{addr=127.0.0.1:59030}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:20.680663Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:22.421497Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:22.422582Z  INFO test{config_path="tests/for_udp/websocket_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:22.422597Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:22.422617Z  INFO config_watcher{path="tests/for_udp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:22.422646Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:22.422653Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:22.422733Z  INFO connection{addr=127.0.0.1:49450}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.422802Z  INFO connection{addr=127.0.0.1:49486}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.422833Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.422878Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.422936Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:22.423002Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.423091Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.423128Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.423175Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.423481Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:22.456791Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:22.456806Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:22.456917Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 487.161504ms... [INFO] [stdout] 2024-03-01T10:00:22.456962Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 566.729381ms... [INFO] [stdout] 2024-03-01T10:00:22.597511Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:22.614815Z  INFO test{config_path="tests/for_tcp/websocket_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:22.614854Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:22.614872Z  INFO config_watcher{path="tests/for_tcp/websocket_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:22.614891Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:22.614898Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:22.614921Z  INFO connection{addr=127.0.0.1:58914}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.614951Z  INFO connection{addr=127.0.0.1:58914}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:22.614973Z  INFO connection{addr=127.0.0.1:59030}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.614993Z  INFO connection{addr=127.0.0.1:59030}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:22.615005Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.615041Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:22.615072Z  INFO connection{addr=127.0.0.1:58914}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:22.615177Z  INFO connection{addr=127.0.0.1:59030}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:22.615297Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] 2024-03-01T10:00:22.615473Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615533Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615589Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615643Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615700Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615764Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615823Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615881Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615936Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.615986Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616037Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616084Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616136Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616189Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616244Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616296Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:22.616694Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:22.648264Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:22.648278Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:22.648378Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 480.494352ms... [INFO] [stdout] 2024-03-01T10:00:22.648420Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 515.381142ms... [INFO] [stdout] 2024-03-01T10:00:22.945602Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.132103759s... [INFO] [stdout] 2024-03-01T10:00:23.024808Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2332: Connection refused (os error 111). Retry in 1.011433944s... [INFO] [stdout] 2024-03-01T10:00:23.130082Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 852.54229ms... [INFO] [stdout] 2024-03-01T10:00:23.164227Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to connect to 127.0.0.1:2333: Connection refused (os error 111). Retry in 977.094604ms... [INFO] [stdout] 2024-03-01T10:00:23.424293Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:23.424524Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:23.460606Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:23.616738Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] 2024-03-01T10:00:23.616952Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:23.651369Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:23.985993Z  INFO connection{addr=127.0.0.1:59204}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:23.986085Z  INFO connection{addr=127.0.0.1:59204}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:23.986182Z  INFO connection{addr=127.0.0.1:59204}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:23.986213Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:24.039552Z  INFO connection{addr=127.0.0.1:49550}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:24.039608Z  INFO connection{addr=127.0.0.1:49550}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:24.039644Z  INFO connection{addr=127.0.0.1:49550}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:24.039702Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:24.080549Z  INFO connection{addr=127.0.0.1:49568}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:24.080617Z  INFO connection{addr=127.0.0.1:49568}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:24.080646Z  INFO connection{addr=127.0.0.1:49568}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:24.080694Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:24.144597Z  INFO connection{addr=127.0.0.1:59272}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:24.144653Z  INFO connection{addr=127.0.0.1:59272}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:24.144766Z  INFO connection{addr=127.0.0.1:59272}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:24.144795Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:25.925515Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:25.926016Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:25.926498Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:25.926513Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:25.926542Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:25.926596Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:25.926646Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:25.926902Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:25.959864Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:25.959882Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:25.962897Z  INFO connection{addr=127.0.0.1:54532}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:25.963876Z  WARN connection{addr=127.0.0.1:54532}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:25.963903Z  INFO connection{addr=127.0.0.1:54532}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:25.964025Z  INFO connection{addr=127.0.0.1:49550}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:25.964087Z  INFO connection{addr=127.0.0.1:54532}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:25.964152Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:25.964268Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:25.964353Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:25.964825Z  INFO connection{addr=127.0.0.1:54540}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:25.966515Z  WARN connection{addr=127.0.0.1:54540}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:25.966537Z  INFO connection{addr=127.0.0.1:54540}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:25.966725Z  INFO connection{addr=127.0.0.1:49568}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:25.966791Z  INFO connection{addr=127.0.0.1:54540}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:25.966854Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:25.966994Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:25.967076Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.117157Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:26.125555Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:26.133586Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] 2024-03-01T10:00:26.133599Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:26.133617Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.133664Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.133711Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] 2024-03-01T10:00:26.133988Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:26.165585Z  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] 2024-03-01T10:00:26.165600Z  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] 2024-03-01T10:00:26.168570Z  INFO connection{addr=127.0.0.1:53834}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:26.169532Z  WARN connection{addr=127.0.0.1:53834}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] 2024-03-01T10:00:26.169553Z  INFO connection{addr=127.0.0.1:53834}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:26.169641Z  INFO connection{addr=127.0.0.1:59204}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.169688Z  INFO connection{addr=127.0.0.1:59204}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:26.169810Z  INFO connection{addr=127.0.0.1:59204}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:26.169974Z  INFO connection{addr=127.0.0.1:53834}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:26.170013Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:26.170237Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170323Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170394Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170470Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170545Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170615Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170682Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.170774Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.171897Z  INFO connection{addr=127.0.0.1:53848}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:26.173435Z  WARN connection{addr=127.0.0.1:53848}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] 2024-03-01T10:00:26.173457Z  INFO connection{addr=127.0.0.1:53848}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:26.173632Z  INFO connection{addr=127.0.0.1:59272}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.173672Z  INFO connection{addr=127.0.0.1:59272}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:26.173767Z  INFO connection{addr=127.0.0.1:59272}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:26.173917Z  INFO connection{addr=127.0.0.1:53848}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:26.173959Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:26.174193Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174265Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174342Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174421Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174501Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174582Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.174664Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.175216Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.927800Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:26.928294Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:26.928765Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:26.928777Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:26.928798Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:26.928805Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:26.929349Z  INFO connection{addr=127.0.0.1:54540}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.929407Z  INFO connection{addr=127.0.0.1:54532}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:26.929473Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:26.929714Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.929791Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.929883Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 426.024909ms... [INFO] [stdout] 2024-03-01T10:00:26.929923Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.930002Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:26.930122Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 456.868446ms... [INFO] [stdout] 2024-03-01T10:00:26.930391Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:26.966621Z  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] 2024-03-01T10:00:27.134899Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] 2024-03-01T10:00:27.143299Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] 2024-03-01T10:00:27.151346Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] 2024-03-01T10:00:27.151358Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:27.151376Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:27.151383Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:27.151873Z  INFO connection{addr=127.0.0.1:53834}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:27.151906Z  INFO connection{addr=127.0.0.1:53834}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:27.151924Z  INFO connection{addr=127.0.0.1:53848}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:27.151955Z  INFO connection{addr=127.0.0.1:53848}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:27.151971Z  INFO connection{addr=127.0.0.1:53834}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:27.152087Z  INFO connection{addr=127.0.0.1:53848}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:27.152225Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] 2024-03-01T10:00:27.152539Z ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 547.218974ms... [INFO] [stdout] 2024-03-01T10:00:27.152616Z ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake. Retry in 460.863948ms... [INFO] [stdout] 2024-03-01T10:00:27.152690Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.152782Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.152862Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.152941Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153022Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153110Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153182Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153269Z  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153350Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153430Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153502Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153584Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153668Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153756Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153832Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.153896Z  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: WebSocket protocol error: Connection reset without closing handshake: Connection reset without closing handshake [INFO] [stdout] 2024-03-01T10:00:27.154190Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] 2024-03-01T10:00:27.188929Z  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] 2024-03-01T10:00:27.359340Z  INFO connection{addr=127.0.0.1:54584}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:27.359417Z  INFO connection{addr=127.0.0.1:54584}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:27.359451Z  INFO connection{addr=127.0.0.1:54584}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:27.359504Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:27.390327Z  INFO connection{addr=127.0.0.1:54608}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:27.390386Z  INFO connection{addr=127.0.0.1:54608}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:27.390418Z  INFO connection{addr=127.0.0.1:54608}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:27.390469Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:27.616717Z  INFO connection{addr=127.0.0.1:54028}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:27.616796Z  INFO connection{addr=127.0.0.1:54028}: rathole::server: Control channel established service=echo [INFO] [stdout] 2024-03-01T10:00:27.616912Z  INFO connection{addr=127.0.0.1:54028}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] 2024-03-01T10:00:27.616942Z  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:27.702406Z  INFO connection{addr=127.0.0.1:54096}: rathole::server: Try to handshake a control channel [INFO] [stdout] 2024-03-01T10:00:27.702461Z  INFO connection{addr=127.0.0.1:54096}: rathole::server: Control channel established service=pingpong [INFO] [stdout] 2024-03-01T10:00:27.702539Z  INFO connection{addr=127.0.0.1:54096}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] 2024-03-01T10:00:27.702560Z  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] 2024-03-01T10:00:29.430472Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:29.431894Z  INFO test{config_path="tests/for_udp/websocket_tls_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:29.431909Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:29.431924Z  INFO config_watcher{path="tests/for_udp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:29.431949Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:29.431958Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:29.432818Z  INFO connection{addr=127.0.0.1:54608}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.432904Z  INFO connection{addr=127.0.0.1:54584}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.432960Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.433045Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] test udp ... ok [INFO] [stdout] 2024-03-01T10:00:29.652948Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] 2024-03-01T10:00:29.682982Z  INFO test{config_path="tests/for_tcp/websocket_tls_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] 2024-03-01T10:00:29.683035Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:29.683066Z  INFO config_watcher{path="tests/for_tcp/websocket_tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] 2024-03-01T10:00:29.683096Z  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] 2024-03-01T10:00:29.683104Z  INFO rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:29.683829Z  INFO connection{addr=127.0.0.1:54028}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.683875Z  INFO connection{addr=127.0.0.1:54028}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:29.683895Z  INFO connection{addr=127.0.0.1:54096}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.683930Z  INFO connection{addr=127.0.0.1:54096}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] 2024-03-01T10:00:29.683946Z  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.684309Z  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] 2024-03-01T10:00:29.684380Z  INFO connection{addr=127.0.0.1:54028}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] 2024-03-01T10:00:29.684554Z  INFO connection{addr=127.0.0.1:54096}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] test tcp ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 35.30s [INFO] [stdout] [INFO] [stderr] Doc-tests rathole [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] running `Command { std: "docker" "inspect" "6453b361f8db81ea594105e9260d439e39504f43166ff87e2d0a48706366774e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6453b361f8db81ea594105e9260d439e39504f43166ff87e2d0a48706366774e", kill_on_drop: false }` [INFO] [stdout] 6453b361f8db81ea594105e9260d439e39504f43166ff87e2d0a48706366774e