[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] 46825810383798daf01000572e9e64a626191ea4 [INFO] testing rapiz1/rathole against beta-2022-02-22 for beta-1.60-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frapiz1%2Frathole" "/workspace/builds/worker-27/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-27/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/rapiz1/rathole on toolchain beta-2022-02-22 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "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-27/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: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded console-subscriber v0.1.3 [INFO] [stderr] Downloaded backoff v0.4.0 [INFO] [stderr] Downloaded console-api v0.1.2 [INFO] [stderr] Downloaded snowstorm v0.3.1 [INFO] [stderr] Downloaded hdrhistogram v7.5.0 [INFO] [stderr] Downloaded vergen v6.0.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 9e3b23033303762168726cc548fae0ff410afeffc14368d88576e2767e7e41db [INFO] running `Command { std: "docker" "start" "-a" "9e3b23033303762168726cc548fae0ff410afeffc14368d88576e2767e7e41db", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "9e3b23033303762168726cc548fae0ff410afeffc14368d88576e2767e7e41db", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9e3b23033303762168726cc548fae0ff410afeffc14368d88576e2767e7e41db", kill_on_drop: false }` [INFO] [stdout] 9e3b23033303762168726cc548fae0ff410afeffc14368d88576e2767e7e41db [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8ffe847260800ef0af8781bf00356364bf1917e55af73e2ade505cd666615ad2 [INFO] running `Command { std: "docker" "start" "-a" "8ffe847260800ef0af8781bf00356364bf1917e55af73e2ade505cd666615ad2", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.119 [INFO] [stderr] Compiling proc-macro2 v1.0.36 [INFO] [stderr] Compiling syn v1.0.86 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling typenum v1.15.0 [INFO] [stderr] Compiling pkg-config v0.3.24 [INFO] [stderr] Compiling serde_derive v1.0.136 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling once_cell v1.9.0 [INFO] [stderr] Compiling parking_lot_core v0.9.1 [INFO] [stderr] Compiling smallvec v1.8.0 [INFO] [stderr] Compiling rustversion v1.0.6 [INFO] [stderr] Compiling pin-project-lite v0.2.8 [INFO] [stderr] Compiling anyhow v1.0.54 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling ppv-lite86 v0.2.16 [INFO] [stderr] Compiling futures-task v0.3.21 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling crossbeam-utils v0.8.7 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling openssl v0.10.38 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling futures-util v0.3.21 [INFO] [stderr] Compiling native-tls v0.2.8 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling heck v0.4.0 [INFO] [stderr] Compiling async-trait v0.1.52 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling termcolor v1.1.2 [INFO] [stderr] Compiling textwrap v0.14.2 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling lock_api v0.4.6 [INFO] [stderr] Compiling thread_local v1.1.4 [INFO] [stderr] Compiling tracing-core v0.1.22 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling generic-array v0.14.5 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling indexmap v1.8.0 [INFO] [stderr] Compiling tracing-log v0.1.2 [INFO] [stderr] Compiling quote v1.0.15 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling os_str_bytes v6.0.0 [INFO] [stderr] Compiling getrandom v0.2.4 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling mio v0.8.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling jobserver v0.1.24 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling crossbeam-channel v0.5.2 [INFO] [stderr] Compiling inotify v0.9.6 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling notify v5.0.0-pre.13 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling cipher v0.3.0 [INFO] [stderr] Compiling universal-hash v0.4.1 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling aead v0.4.3 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling crypto-common v0.1.3 [INFO] [stderr] Compiling block-buffer v0.10.2 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling libz-sys v1.1.3 [INFO] [stderr] Compiling openssl-sys v0.9.72 [INFO] [stderr] Compiling libgit2-sys v0.12.26+1.3.0 [INFO] [stderr] Compiling rustc_version v0.3.3 [INFO] [stderr] Compiling blake2 v0.9.2 [INFO] [stderr] Compiling polyval v0.5.3 [INFO] [stderr] Compiling poly1305 v0.7.2 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling digest v0.10.3 [INFO] [stderr] Compiling ctr v0.8.0 [INFO] [stderr] Compiling aes v0.7.5 [INFO] [stderr] Compiling ghash v0.4.4 [INFO] [stderr] Compiling sha2 v0.10.2 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling snow v0.8.0 [INFO] [stderr] Compiling aes-gcm v0.9.4 [INFO] [stderr] Compiling vergen v6.0.2 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling git2 v0.13.25 [INFO] [stderr] Compiling zeroize_derive v1.3.2 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling enum-iterator-derive v0.7.0 [INFO] [stderr] Compiling tokio-macros v1.7.0 [INFO] [stderr] Compiling getset v0.1.2 [INFO] [stderr] Compiling tracing-attributes v0.1.19 [INFO] [stderr] Compiling futures-macro v0.3.21 [INFO] [stderr] Compiling pin-project-internal v1.0.10 [INFO] [stderr] Compiling clap_derive v3.1.0 [INFO] [stderr] Compiling enum-iterator v0.7.0 [INFO] [stderr] Compiling zeroize v1.3.0 [INFO] [stderr] Compiling chacha20 v0.7.3 [INFO] [stderr] Compiling curve25519-dalek v3.2.1 [INFO] [stderr] Compiling chacha20poly1305 v0.8.2 [INFO] [stderr] Compiling pin-project v1.0.10 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling tracing v0.1.31 [INFO] [stderr] Compiling x25519-dalek v1.2.0 [INFO] [stderr] Compiling clap v3.1.0 [INFO] [stderr] Compiling rathole v0.3.10 (/opt/rustwide/workdir) [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling tokio v1.17.0 [INFO] [stderr] Compiling tracing-subscriber v0.2.25 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling tokio-native-tls v0.3.0 [INFO] [stderr] Compiling snowstorm v0.3.1 [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 31.03s [INFO] running `Command { std: "docker" "inspect" "8ffe847260800ef0af8781bf00356364bf1917e55af73e2ade505cd666615ad2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8ffe847260800ef0af8781bf00356364bf1917e55af73e2ade505cd666615ad2", kill_on_drop: false }` [INFO] [stdout] 8ffe847260800ef0af8781bf00356364bf1917e55af73e2ade505cd666615ad2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 273f972aef9df82abf70670d4c5089e11a2d5e1bfe8f1d710c6598da8aceb520 [INFO] running `Command { std: "docker" "start" "-a" "273f972aef9df82abf70670d4c5089e11a2d5e1bfe8f1d710c6598da8aceb520", kill_on_drop: false }` [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling once_cell v1.9.0 [INFO] [stderr] Compiling pin-project-lite v0.2.8 [INFO] [stderr] Compiling smallvec v1.8.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.16 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling textwrap v0.14.2 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling lock_api v0.4.6 [INFO] [stderr] Compiling tracing-core v0.1.22 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling typenum v1.15.0 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling crossbeam-utils v0.8.7 [INFO] [stderr] Compiling getrandom v0.2.4 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling mio v0.8.0 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling futures-task v0.3.21 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling indexmap v1.8.0 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling pin-project v1.0.10 [INFO] [stderr] Compiling zeroize v1.3.0 [INFO] [stderr] Compiling openssl-sys v0.9.72 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling thread_local v1.1.4 [INFO] [stderr] Compiling parking_lot_core v0.9.1 [INFO] [stderr] Compiling tracing-log v0.1.2 [INFO] [stderr] Compiling tracing v0.1.31 [INFO] [stderr] Compiling crossbeam-channel v0.5.2 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling inotify v0.9.6 [INFO] [stderr] Compiling futures-util v0.3.21 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling os_str_bytes v6.0.0 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling generic-array v0.14.5 [INFO] [stderr] Compiling clap v3.1.0 [INFO] [stderr] Compiling notify v5.0.0-pre.13 [INFO] [stderr] Compiling openssl v0.10.38 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling universal-hash v0.4.1 [INFO] [stderr] Compiling cipher v0.3.0 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling aead v0.4.3 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-common v0.1.3 [INFO] [stderr] Compiling block-buffer v0.10.2 [INFO] [stderr] Compiling polyval v0.5.3 [INFO] [stderr] Compiling poly1305 v0.7.2 [INFO] [stderr] Compiling digest v0.10.3 [INFO] [stderr] Compiling ctr v0.8.0 [INFO] [stderr] Compiling chacha20 v0.7.3 [INFO] [stderr] Compiling aes v0.7.5 [INFO] [stderr] Compiling curve25519-dalek v3.2.1 [INFO] [stderr] Compiling blake2 v0.9.2 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling ghash v0.4.4 [INFO] [stderr] Compiling chacha20poly1305 v0.8.2 [INFO] [stderr] Compiling sha2 v0.10.2 [INFO] [stderr] Compiling aes-gcm v0.9.4 [INFO] [stderr] Compiling x25519-dalek v1.2.0 [INFO] [stderr] Compiling snow v0.8.0 [INFO] [stderr] Compiling native-tls v0.2.8 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling tokio v1.17.0 [INFO] [stderr] Compiling tracing-subscriber v0.2.25 [INFO] [stderr] Compiling snowstorm v0.3.1 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling tokio-native-tls v0.3.0 [INFO] [stderr] Compiling rathole v0.3.10 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 23.77s [INFO] running `Command { std: "docker" "inspect" "273f972aef9df82abf70670d4c5089e11a2d5e1bfe8f1d710c6598da8aceb520", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "273f972aef9df82abf70670d4c5089e11a2d5e1bfe8f1d710c6598da8aceb520", kill_on_drop: false }` [INFO] [stdout] 273f972aef9df82abf70670d4c5089e11a2d5e1bfe8f1d710c6598da8aceb520 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] e80ecdc56c092e45494c9aadb28156d66ec38ff737318ad4ea9bdc1c910cdcb5 [INFO] running `Command { std: "docker" "start" "-a" "e80ecdc56c092e45494c9aadb28156d66ec38ff737318ad4ea9bdc1c910cdcb5", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.09s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/rathole-b512b656f05e9172) [INFO] [stdout] [INFO] [stdout] running 7 tests [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_example_config ... ok [INFO] [stdout] test config::tests::test_validate_server_config ... ok [INFO] [stdout] test config_watcher::test::test_calculate_events ... ok [INFO] [stdout] test config::tests::test_invalid_config ... ok [INFO] [stdout] test config::tests::test_valid_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 (/opt/rustwide/target/debug/deps/rathole-dc63ec554fe09455) [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-6018a0031d8a4c44) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] Mar 01 00:39:31.049  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:31.050  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:31.051  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:31.051  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:31.052  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:31.052  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:31.052 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 481.064228ms... [INFO] [stdout] Mar 01 00:39:31.052 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 454.805103ms... [INFO] [stdout] Mar 01 00:39:31.052  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:31.052  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:31.053 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 503.910927ms... [INFO] [stdout] Mar 01 00:39:31.053 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 528.011604ms... [INFO] [stdout] Mar 01 00:39:31.508 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 787.325187ms... [INFO] [stdout] Mar 01 00:39:31.534 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 820.601299ms... [INFO] [stdout] Mar 01 00:39:31.558 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 775.969329ms... [INFO] [stdout] Mar 01 00:39:31.582 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 746.927699ms... [INFO] [stdout] Mar 01 00:39:32.051  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:32.051  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:32.052  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:32.052  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:32.053  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:32.053  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:32.296  INFO connection{addr=127.0.0.1:57392}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:32.296  INFO connection{addr=127.0.0.1:57392}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:32.296  INFO connection{addr=127.0.0.1:57392}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:32.297  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:32.331  INFO connection{addr=127.0.0.1:52920}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:32.331  INFO connection{addr=127.0.0.1:52920}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:32.331  INFO connection{addr=127.0.0.1:52920}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:32.332  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:32.335  INFO connection{addr=127.0.0.1:52926}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:32.335  INFO connection{addr=127.0.0.1:52926}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:32.336  INFO connection{addr=127.0.0.1:52926}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:32.336  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:32.370  INFO connection{addr=127.0.0.1:57436}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:32.370  INFO connection{addr=127.0.0.1:57436}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:32.371  INFO connection{addr=127.0.0.1:57436}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:32.371  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:34.551  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:34.552  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:34.554  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:34.556  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:34.556  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:34.556  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.556  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.556  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:34.558  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:34.558  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:34.558  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:34.559  INFO connection{addr=127.0.0.1:52980}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:34.559  INFO connection{addr=127.0.0.1:52982}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:34.560  WARN connection{addr=127.0.0.1:52980}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:34.560  INFO connection{addr=127.0.0.1:52980}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:34.560  WARN connection{addr=127.0.0.1:52982}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:34.560  INFO connection{addr=127.0.0.1:52982}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:34.561  INFO connection{addr=127.0.0.1:52926}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.561  INFO connection{addr=127.0.0.1:52980}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:34.561  INFO connection{addr=127.0.0.1:52920}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.561  INFO connection{addr=127.0.0.1:52982}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:34.562  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:34.562  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:34.562  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:34.562  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.562  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:34.563  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.576  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:34.591  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:34.591  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:34.591  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.592  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.592  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:34.593  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:34.593  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:34.593  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:34.593  INFO connection{addr=127.0.0.1:57538}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:34.594  INFO connection{addr=127.0.0.1:57540}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:34.594  WARN connection{addr=127.0.0.1:57538}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:34.594  INFO connection{addr=127.0.0.1:57538}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:34.594  WARN connection{addr=127.0.0.1:57540}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:34.594  INFO connection{addr=127.0.0.1:57540}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57392}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57392}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57436}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57436}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57392}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:34.595  INFO connection{addr=127.0.0.1:57538}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:34.596  INFO connection{addr=127.0.0.1:57436}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:34.596  INFO connection{addr=127.0.0.1:57540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:34.596  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:34.596  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:34.596  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.596  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.596  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.596  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.597  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.598  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.598  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.598  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:34.598  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.558  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:35.561  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:35.563  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:35.563  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:35.563  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:35.563  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:35.563  INFO connection{addr=127.0.0.1:52980}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:35.563  INFO connection{addr=127.0.0.1:52982}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:35.564  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:35.564 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 463.844858ms... [INFO] [stdout] Mar 01 00:39:35.564  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:35.564  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.564 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 488.009906ms... [INFO] [stdout] Mar 01 00:39:35.564  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:35.565  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.567  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:35.567  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:35.593  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:35.617  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:35.632  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:35.633  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:35.633  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:35.633  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57538}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57538}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57540}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57538}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:35.633  INFO connection{addr=127.0.0.1:57540}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:35.634  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:35.634 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 520.667042ms... [INFO] [stdout] Mar 01 00:39:35.634 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 477.86183ms... [INFO] [stdout] Mar 01 00:39:35.634  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.634  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.634  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.634  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.635  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.636  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.636  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.636  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:35.637  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:35.637  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:36.029  INFO connection{addr=127.0.0.1:53102}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:36.030  INFO connection{addr=127.0.0.1:53102}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:36.030  INFO connection{addr=127.0.0.1:53102}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:36.030  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:36.055  INFO connection{addr=127.0.0.1:53112}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:36.055  INFO connection{addr=127.0.0.1:53112}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:36.055  INFO connection{addr=127.0.0.1:53112}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:36.055  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:36.114  INFO connection{addr=127.0.0.1:57624}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:36.114  INFO connection{addr=127.0.0.1:57624}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:36.115  INFO connection{addr=127.0.0.1:57624}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:36.115  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:36.156  INFO connection{addr=127.0.0.1:57658}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:36.156  INFO connection{addr=127.0.0.1:57658}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:36.157  INFO connection{addr=127.0.0.1:57658}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:36.157  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:38.067  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:38.072  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:38.072  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:38.072  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:38.072  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:38.072  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:38.072  INFO connection{addr=127.0.0.1:53102}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.073  INFO connection{addr=127.0.0.1:53112}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.073  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.073  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.073  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:38.073  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:38.074  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.074  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:38.074  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.076  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:38.083  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:38.083  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:38.084 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 508.441577ms... [INFO] [stdout] Mar 01 00:39:38.084 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 537.97626ms... [INFO] [stdout] Mar 01 00:39:38.134  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:38.189  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:38.189  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:38.189  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:38.189  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:38.189  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:38.189  INFO connection{addr=127.0.0.1:57624}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO connection{addr=127.0.0.1:57624}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO connection{addr=127.0.0.1:57658}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO connection{addr=127.0.0.1:57658}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO connection{addr=127.0.0.1:57624}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:38.190  INFO connection{addr=127.0.0.1:57658}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:38.191  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.192  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:38.194  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:38.198  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:38.198  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:38.198 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 483.565728ms... [INFO] [stdout] Mar 01 00:39:38.198 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 497.867729ms... [INFO] [stdout] Mar 01 00:39:38.593 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 789.76637ms... [INFO] [stdout] Mar 01 00:39:38.623 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 736.185128ms... [INFO] [stdout] Mar 01 00:39:38.684 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 695.015627ms... [INFO] [stdout] Mar 01 00:39:38.698 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 781.635718ms... [INFO] [stdout] Mar 01 00:39:39.075  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:39.077  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:39.079  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:39.192  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:39.193  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:39.194  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:39.368  INFO connection{addr=127.0.0.1:53288}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:39.368  INFO connection{addr=127.0.0.1:53288}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:39.369  INFO connection{addr=127.0.0.1:53288}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:39.369  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:39.387  INFO connection{addr=127.0.0.1:57792}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:39.387  INFO connection{addr=127.0.0.1:57792}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:39.387  INFO connection{addr=127.0.0.1:57792}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:39.387  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:39.389  INFO connection{addr=127.0.0.1:53296}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:39.390  INFO connection{addr=127.0.0.1:53296}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:39.390  INFO connection{addr=127.0.0.1:53296}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:39.390  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:39.486  INFO connection{addr=127.0.0.1:57834}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:39.486  INFO connection{addr=127.0.0.1:57834}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:39.487  INFO connection{addr=127.0.0.1:57834}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:39.487  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:41.576  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:41.578  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:41.581  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:41.581  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:41.581  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.581  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.581  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:41.583  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:41.589  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:41.590  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:41.600  INFO connection{addr=127.0.0.1:53384}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:41.601  WARN connection{addr=127.0.0.1:53384}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:41.601  INFO connection{addr=127.0.0.1:53384}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:41.602  INFO connection{addr=127.0.0.1:53288}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.602  INFO connection{addr=127.0.0.1:53384}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:41.602  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:41.603  INFO connection{addr=127.0.0.1:53386}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:41.603  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:41.603  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.604  WARN connection{addr=127.0.0.1:53386}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:41.604  INFO connection{addr=127.0.0.1:53386}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:41.609  INFO connection{addr=127.0.0.1:53296}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.609  INFO connection{addr=127.0.0.1:53386}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:41.609  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:41.610  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:41.610  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.693  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:41.730  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:41.756  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:41.756  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:41.756  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.756  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.756  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:41.757  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:41.761  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:41.762  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:41.772  INFO connection{addr=127.0.0.1:57918}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:41.773  WARN connection{addr=127.0.0.1:57918}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:41.773  INFO connection{addr=127.0.0.1:57918}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:41.773  INFO connection{addr=127.0.0.1:57792}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:41.773  INFO connection{addr=127.0.0.1:57792}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.774  INFO connection{addr=127.0.0.1:57792}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:41.774  INFO connection{addr=127.0.0.1:57918}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:41.774  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:41.774  INFO connection{addr=127.0.0.1:57920}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:41.774  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.777  WARN connection{addr=127.0.0.1:57920}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:41.777  INFO connection{addr=127.0.0.1:57920}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:41.782  INFO connection{addr=127.0.0.1:57834}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:41.782  INFO connection{addr=127.0.0.1:57834}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:41.782  INFO connection{addr=127.0.0.1:57834}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:41.782  INFO connection{addr=127.0.0.1:57920}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:41.782  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:41.783  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.783  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.783  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.783  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.784  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.784  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.784  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:41.785  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.583  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:42.585  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:42.634  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:42.634  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:42.635  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:42.635  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:42.635  INFO connection{addr=127.0.0.1:53386}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:42.635  INFO connection{addr=127.0.0.1:53384}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:42.635  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:42.636 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 479.359121ms... [INFO] [stdout] Mar 01 00:39:42.636  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:42.636  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.636 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 463.691996ms... [INFO] [stdout] Mar 01 00:39:42.636  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:42.636  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.638  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:42.640  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:42.758  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:42.795  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:42.821  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:42.821  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:42.821  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:42.821  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:42.821  INFO connection{addr=127.0.0.1:57920}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:42.821  INFO connection{addr=127.0.0.1:57920}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:42.821  INFO connection{addr=127.0.0.1:57918}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:42.822  INFO connection{addr=127.0.0.1:57918}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:42.822  INFO connection{addr=127.0.0.1:57920}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:42.822  INFO connection{addr=127.0.0.1:57918}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:42.822  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:42.822 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 505.237684ms... [INFO] [stdout] Mar 01 00:39:42.822 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 500.257511ms... [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.823  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.824  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.825  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.825  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.825  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:42.826  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:42.827  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:43.108  INFO connection{addr=127.0.0.1:53528}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:43.108  INFO connection{addr=127.0.0.1:53528}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:43.109  INFO connection{addr=127.0.0.1:53528}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:43.109  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:43.126  INFO connection{addr=127.0.0.1:53534}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:43.126  INFO connection{addr=127.0.0.1:53534}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:43.127  INFO connection{addr=127.0.0.1:53534}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:43.127  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:43.335  INFO connection{addr=127.0.0.1:58038}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:43.335  INFO connection{addr=127.0.0.1:58038}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:43.336  INFO connection{addr=127.0.0.1:58038}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:43.336  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:43.336  INFO connection{addr=127.0.0.1:58040}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:43.338  INFO connection{addr=127.0.0.1:58040}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:43.343  INFO connection{addr=127.0.0.1:58040}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:43.343  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:45.136  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:45.142  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:45.142  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:45.142  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:45.142  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:45.142  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:45.143  INFO connection{addr=127.0.0.1:53534}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.143  INFO connection{addr=127.0.0.1:53528}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.143  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.143  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.144  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:45.144  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:45.144  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.144  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:45.144  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.146  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:45.148  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:45.148  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:45.148 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 466.171419ms... [INFO] [stdout] Mar 01 00:39:45.148 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 514.941957ms... [INFO] [stdout] Mar 01 00:39:45.322  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:45.413  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:45.413  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:45.413  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:45.413  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:45.413  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:45.413  INFO connection{addr=127.0.0.1:58040}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:45.413  INFO connection{addr=127.0.0.1:58040}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.413  INFO connection{addr=127.0.0.1:58038}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO connection{addr=127.0.0.1:58038}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO connection{addr=127.0.0.1:58040}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO connection{addr=127.0.0.1:58038}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:45.414  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.415  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.416  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.417  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.417  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.417  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:45.418  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:45.419  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:45.419  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:45.420 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 525.654787ms... [INFO] [stdout] Mar 01 00:39:45.420 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 523.011241ms... [INFO] [stdout] Mar 01 00:39:45.616 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 798.109144ms... [INFO] [stdout] Mar 01 00:39:45.665 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 698.552207ms... [INFO] [stdout] Mar 01 00:39:45.944 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 752.455929ms... [INFO] [stdout] Mar 01 00:39:45.947 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 702.438818ms... [INFO] [stdout] Mar 01 00:39:46.145  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:46.147  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:46.148  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:46.376  INFO connection{addr=127.0.0.1:53700}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:46.377  INFO connection{addr=127.0.0.1:53700}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:46.377  INFO connection{addr=127.0.0.1:53700}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:46.378  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:46.416  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] Mar 01 00:39:46.417  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:46.418  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:46.428  INFO connection{addr=127.0.0.1:53710}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:46.429  INFO connection{addr=127.0.0.1:53710}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:46.429  INFO connection{addr=127.0.0.1:53710}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:46.430  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:46.658  INFO connection{addr=127.0.0.1:58214}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:46.658  INFO connection{addr=127.0.0.1:58214}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:46.659  INFO connection{addr=127.0.0.1:58214}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:46.659  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:46.729  INFO connection{addr=127.0.0.1:58232}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:46.730  INFO connection{addr=127.0.0.1:58232}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:46.731  INFO connection{addr=127.0.0.1:58232}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:46.731  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:48.647  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:48.695  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:48.743  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:48.743  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:48.743  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:48.744  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:48.744  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:48.746  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:48.747  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:48.747  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:48.769  INFO connection{addr=127.0.0.1:53804}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:48.772  INFO connection{addr=127.0.0.1:53806}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:48.773  WARN connection{addr=127.0.0.1:53804}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:48.773  INFO connection{addr=127.0.0.1:53804}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:48.773  INFO connection{addr=127.0.0.1:53700}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:48.774  INFO connection{addr=127.0.0.1:53804}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:48.774  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:48.775  WARN connection{addr=127.0.0.1:53806}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:48.775  INFO connection{addr=127.0.0.1:53806}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:48.775  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:48.776  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:48.776  INFO connection{addr=127.0.0.1:53710}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:48.776  INFO connection{addr=127.0.0.1:53806}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:48.777  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:48.786  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:48.786  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:48.918  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:49.070  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:49.127  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] Mar 01 00:39:49.127  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:49.127  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.127  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.127  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] Mar 01 00:39:49.128  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:49.129  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] Mar 01 00:39:49.129  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] Mar 01 00:39:49.143  INFO connection{addr=127.0.0.1:58342}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:49.145  INFO connection{addr=127.0.0.1:58344}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:49.146  WARN connection{addr=127.0.0.1:58342}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] Mar 01 00:39:49.146  INFO connection{addr=127.0.0.1:58342}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:49.146  INFO connection{addr=127.0.0.1:58214}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:49.146  INFO connection{addr=127.0.0.1:58214}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.147  INFO connection{addr=127.0.0.1:58214}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:49.147  INFO connection{addr=127.0.0.1:58342}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:49.147  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:49.148  WARN connection{addr=127.0.0.1:58344}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] Mar 01 00:39:49.148  INFO connection{addr=127.0.0.1:58344}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.149  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.150  INFO connection{addr=127.0.0.1:58232}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:49.150  INFO connection{addr=127.0.0.1:58232}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.151  INFO connection{addr=127.0.0.1:58232}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:49.151  INFO connection{addr=127.0.0.1:58344}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:49.151  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:49.171  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.171  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.171  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.172  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.172  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.172  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.172  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.172  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.745  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:49.752  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:49.804  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:49.804  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:49.804  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:49.805  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:49.805  INFO connection{addr=127.0.0.1:53804}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.805  INFO connection{addr=127.0.0.1:53806}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:49.805  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:49.805 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 498.584326ms... [INFO] [stdout] Mar 01 00:39:49.806  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:49.806  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.806 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 543.951378ms... [INFO] [stdout] Mar 01 00:39:49.806  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] Mar 01 00:39:49.806  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:49.808  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:49.809  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] Mar 01 00:39:50.129  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] Mar 01 00:39:50.280  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] Mar 01 00:39:50.317  INFO connection{addr=127.0.0.1:53956}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:50.318  INFO connection{addr=127.0.0.1:53956}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:50.319  INFO connection{addr=127.0.0.1:53956}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:50.319  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:50.337  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] Mar 01 00:39:50.337  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:50.337  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:50.338  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58342}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58342}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58344}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58344}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58342}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO connection{addr=127.0.0.1:58344}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:50.338  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] Mar 01 00:39:50.339 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 483.072981ms... [INFO] [stdout] Mar 01 00:39:50.339 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 533.027302ms... [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.339  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.340  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.341  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.341  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] Mar 01 00:39:50.342  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] Mar 01 00:39:50.342  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] Mar 01 00:39:50.363  INFO connection{addr=127.0.0.1:53962}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:50.364  INFO connection{addr=127.0.0.1:53962}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:50.364  INFO connection{addr=127.0.0.1:53962}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:50.365  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:50.831  INFO connection{addr=127.0.0.1:58466}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:50.832  INFO connection{addr=127.0.0.1:58466}: rathole::server: Control channel established service=echo [INFO] [stdout] Mar 01 00:39:50.833  INFO connection{addr=127.0.0.1:58466}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] Mar 01 00:39:50.833  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:50.903  INFO connection{addr=127.0.0.1:58502}: rathole::server: Try to handshake a control channel [INFO] [stdout] Mar 01 00:39:50.903  INFO connection{addr=127.0.0.1:58502}: rathole::server: Control channel established service=pingpong [INFO] [stdout] Mar 01 00:39:50.904  INFO connection{addr=127.0.0.1:58502}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] Mar 01 00:39:50.904  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] Mar 01 00:39:52.307  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:52.411  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:52.411  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:52.412  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:52.412  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:52.412  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:52.412  INFO connection{addr=127.0.0.1:53962}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:52.412  INFO connection{addr=127.0.0.1:53956}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:52.413  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:52.413  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] test udp ... ok [INFO] [stdout] Mar 01 00:39:52.840  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] Mar 01 00:39:53.216  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] Mar 01 00:39:53.216  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:53.216  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] Mar 01 00:39:53.216  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] Mar 01 00:39:53.216  INFO rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:53.216  INFO connection{addr=127.0.0.1:58502}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:53.216  INFO connection{addr=127.0.0.1:58502}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO connection{addr=127.0.0.1:58466}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO connection{addr=127.0.0.1:58466}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO connection{addr=127.0.0.1:58502}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] Mar 01 00:39:53.217  INFO connection{addr=127.0.0.1:58466}:handle{service=echo}: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 22.19s [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" "e80ecdc56c092e45494c9aadb28156d66ec38ff737318ad4ea9bdc1c910cdcb5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e80ecdc56c092e45494c9aadb28156d66ec38ff737318ad4ea9bdc1c910cdcb5", kill_on_drop: false }` [INFO] [stdout] e80ecdc56c092e45494c9aadb28156d66ec38ff737318ad4ea9bdc1c910cdcb5