[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] 8665e6a2cfb57ddfc4b0f5a8cf116b3a69d06521 [INFO] testing rapiz1/rathole against try#c3758fdc4730d7700b25a13cccff296a08f42c00 for pr-91743 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frapiz1%2Frathole" "/workspace/builds/worker-60/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-60/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/rapiz1/rathole on toolchain c3758fdc4730d7700b25a13cccff296a08f42c00 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "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-60/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" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] d0a5a6d01f26a11c26deb75838b32dfd8d67f8f9158a7a2743c986cb7662eaee [INFO] running `Command { std: "docker" "start" "-a" "d0a5a6d01f26a11c26deb75838b32dfd8d67f8f9158a7a2743c986cb7662eaee", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "d0a5a6d01f26a11c26deb75838b32dfd8d67f8f9158a7a2743c986cb7662eaee", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d0a5a6d01f26a11c26deb75838b32dfd8d67f8f9158a7a2743c986cb7662eaee", kill_on_drop: false }` [INFO] [stdout] d0a5a6d01f26a11c26deb75838b32dfd8d67f8f9158a7a2743c986cb7662eaee [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3c7f26dff9f21819d74d2d93c253644399c9867869358f35d9a19bc75b09df17 [INFO] running `Command { std: "docker" "start" "-a" "3c7f26dff9f21819d74d2d93c253644399c9867869358f35d9a19bc75b09df17", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.119 [INFO] [stderr] Compiling proc-macro2 v1.0.36 [INFO] [stderr] Compiling unicode-xid v0.2.2 [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 log v0.4.14 [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling parking_lot_core v0.9.1 [INFO] [stderr] Compiling smallvec v1.8.0 [INFO] [stderr] Compiling pin-project-lite v0.2.8 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling rustversion v1.0.6 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling unicode-bidi v0.3.7 [INFO] [stderr] Compiling anyhow v1.0.56 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling ppv-lite86 v0.2.16 [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling futures-task v0.3.21 [INFO] [stderr] Compiling openssl v0.10.38 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling crossbeam-utils v0.8.7 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling native-tls v0.2.8 [INFO] [stderr] Compiling httparse v1.6.0 [INFO] [stderr] Compiling async-trait v0.1.52 [INFO] [stderr] Compiling futures-util v0.3.21 [INFO] [stderr] Compiling heck v0.4.0 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling textwrap v0.15.0 [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling lock_api v0.4.6 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling tracing-core v0.1.23 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [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 thread_local v1.1.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 crossbeam-channel v0.5.2 [INFO] [stderr] Compiling quote v1.0.15 [INFO] [stderr] Compiling os_str_bytes v6.0.0 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling jobserver v0.1.24 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling mio v0.8.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling getrandom v0.2.5 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling inotify v0.9.6 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling notify v5.0.0-pre.13 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling rustc_version v0.3.3 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling idna v0.2.3 [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 block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling block-buffer v0.10.2 [INFO] [stderr] Compiling crypto-common v0.1.3 [INFO] [stderr] Compiling snow v0.8.0 [INFO] [stderr] Compiling polyval v0.5.3 [INFO] [stderr] Compiling poly1305 v0.7.2 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling blake2 v0.9.2 [INFO] [stderr] Compiling digest v0.10.3 [INFO] [stderr] Compiling ctr v0.8.0 [INFO] [stderr] Compiling aes v0.7.5 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex v1.5.5 [INFO] [stderr] Compiling ghash v0.4.4 [INFO] [stderr] Compiling sha2 v0.10.2 [INFO] [stderr] Compiling libz-sys v1.1.5 [INFO] [stderr] Compiling openssl-sys v0.9.72 [INFO] [stderr] Compiling libgit2-sys v0.13.1+1.4.2 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling aes-gcm v0.9.4 [INFO] [stderr] Compiling vergen v6.0.2 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling git2 v0.14.1 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling zeroize_derive v1.3.2 [INFO] [stderr] Compiling tokio-macros v1.7.0 [INFO] [stderr] Compiling enum-iterator-derive v0.7.0 [INFO] [stderr] Compiling getset v0.1.2 [INFO] [stderr] Compiling futures-macro v0.3.21 [INFO] [stderr] Compiling pin-project-internal v1.0.10 [INFO] [stderr] Compiling tracing-attributes v0.1.20 [INFO] [stderr] Compiling clap_derive v3.1.4 [INFO] [stderr] Compiling enum-iterator v0.7.0 [INFO] [stderr] Compiling zeroize v1.3.0 [INFO] [stderr] Compiling curve25519-dalek v3.2.1 [INFO] [stderr] Compiling chacha20 v0.7.3 [INFO] [stderr] Compiling chacha20poly1305 v0.8.2 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling pin-project v1.0.10 [INFO] [stderr] Compiling tracing v0.1.31 [INFO] [stderr] Compiling x25519-dalek v1.2.0 [INFO] [stderr] Compiling clap v3.1.6 [INFO] [stderr] Compiling rathole v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling toml v0.5.8 [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 async-socks5 v0.5.1 [INFO] [stderr] Compiling tokio-native-tls v0.3.0 [INFO] [stderr] Compiling async-http-proxy v1.2.5 [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2m 02s [INFO] running `Command { std: "docker" "inspect" "3c7f26dff9f21819d74d2d93c253644399c9867869358f35d9a19bc75b09df17", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3c7f26dff9f21819d74d2d93c253644399c9867869358f35d9a19bc75b09df17", kill_on_drop: false }` [INFO] [stdout] 3c7f26dff9f21819d74d2d93c253644399c9867869358f35d9a19bc75b09df17 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 2e598b3b8ccb53a4bd0f0170d80bfe7a80088afdd29e7e7301957673d5228c1d [INFO] running `Command { std: "docker" "start" "-a" "2e598b3b8ccb53a4bd0f0170d80bfe7a80088afdd29e7e7301957673d5228c1d", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.16 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling textwrap v0.15.0 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling tracing-core v0.1.23 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling typenum v1.15.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling lock_api v0.4.6 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling futures-task v0.3.21 [INFO] [stderr] Compiling crossbeam-utils v0.8.7 [INFO] [stderr] Compiling parking_lot_core v0.9.1 [INFO] [stderr] Compiling getrandom v0.2.5 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling filetime v0.2.15 [INFO] [stderr] Compiling httparse v1.6.0 [INFO] [stderr] Compiling fdlimit v0.2.1 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling thread_local v1.1.4 [INFO] [stderr] Compiling walkdir v2.3.2 [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 futures-util v0.3.21 [INFO] [stderr] Compiling mio v0.8.0 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling inotify v0.9.6 [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 tracing v0.1.31 [INFO] [stderr] Compiling tracing-log v0.1.2 [INFO] [stderr] Compiling crossbeam-channel v0.5.2 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling os_str_bytes v6.0.0 [INFO] [stderr] Compiling indexmap v1.8.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling generic-array v0.14.5 [INFO] [stderr] Compiling openssl v0.10.38 [INFO] [stderr] Compiling notify v5.0.0-pre.13 [INFO] [stderr] Compiling clap v3.1.6 [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 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 curve25519-dalek v3.2.1 [INFO] [stderr] Compiling blake2 v0.9.2 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling digest v0.10.3 [INFO] [stderr] Compiling aes v0.7.5 [INFO] [stderr] Compiling ctr v0.8.0 [INFO] [stderr] Compiling chacha20 v0.7.3 [INFO] [stderr] Compiling ghash v0.4.4 [INFO] [stderr] Compiling sha2 v0.10.2 [INFO] [stderr] Compiling chacha20poly1305 v0.8.2 [INFO] [stderr] Compiling aes-gcm v0.9.4 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex v1.5.5 [INFO] [stderr] Compiling x25519-dalek v1.2.0 [INFO] [stderr] Compiling snow v0.8.0 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling native-tls v0.2.8 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling url v2.2.2 [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 async-socks5 v0.5.1 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling async-http-proxy v1.2.5 [INFO] [stderr] Compiling tokio-native-tls v0.3.0 [INFO] [stderr] Compiling snowstorm v0.3.1 [INFO] [stderr] Compiling rathole v0.4.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 56.81s [INFO] [stderr] Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/rathole-a4d338eabfca104e) [INFO] [stderr] Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/rathole-31ec9bf68233c696) [INFO] [stderr] Executable tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-946f1e482d5da1cc) [INFO] running `Command { std: "docker" "inspect" "2e598b3b8ccb53a4bd0f0170d80bfe7a80088afdd29e7e7301957673d5228c1d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2e598b3b8ccb53a4bd0f0170d80bfe7a80088afdd29e7e7301957673d5228c1d", kill_on_drop: false }` [INFO] [stdout] 2e598b3b8ccb53a4bd0f0170d80bfe7a80088afdd29e7e7301957673d5228c1d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] d19d661e21d189cfcbdb3233f27ec5d70252a1cc4974331ef4e5d3cb9ebce21b [INFO] running `Command { std: "docker" "start" "-a" "d19d661e21d189cfcbdb3233f27ec5d70252a1cc4974331ef4e5d3cb9ebce21b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 2.56s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rathole-a4d338eabfca104e) [INFO] [stdout] running 7 tests [INFO] [stdout] test config::tests::test_validate_client_config ... ok [INFO] [stdout] test config_watcher::test::test_calculate_events ... ok [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rathole-31ec9bf68233c696) [INFO] [stdout] test tests::test_determine_run_mode ... ok [INFO] [stdout] test config::tests::test_valid_config ... ok [INFO] [stdout] test config::tests::test_validate_server_config ... ok [INFO] [stdout] test config::tests::test_invalid_config ... ok [INFO] [stdout] test config::tests::test_example_config ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-946f1e482d5da1cc) [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] May 05 02:12:25.635  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] May 05 02:12:25.635  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] May 05 02:12:25.654  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:25.654  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:25.654  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:25.655 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 515.743876ms... [INFO] [stdout] May 05 02:12:25.655 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 464.579245ms... [INFO] [stdout] May 05 02:12:25.669  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:25.669  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:25.669  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:25.670 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 530.793955ms... [INFO] [stdout] May 05 02:12:25.670 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 484.45313ms... [INFO] [stdout] May 05 02:12:26.122 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 766.225248ms... [INFO] [stdout] May 05 02:12:26.157 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 717.526631ms... [INFO] [stdout] May 05 02:12:26.172 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 721.499739ms... [INFO] [stdout] May 05 02:12:26.206 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 709.718554ms... [INFO] [stdout] May 05 02:12:26.637  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] May 05 02:12:26.637  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] May 05 02:12:26.642  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:26.642  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:26.642  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:26.643  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:26.876  INFO connection{addr=127.0.0.1:41042}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:26.877  INFO connection{addr=127.0.0.1:41042}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:26.877  INFO connection{addr=127.0.0.1:41042}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:26.877  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:26.891  INFO connection{addr=127.0.0.1:44334}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:26.891  INFO connection{addr=127.0.0.1:44334}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:26.892  INFO connection{addr=127.0.0.1:44334}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:26.892  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:26.895  INFO connection{addr=127.0.0.1:44340}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:26.896  INFO connection{addr=127.0.0.1:44340}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:26.896  INFO connection{addr=127.0.0.1:44340}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:26.896  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:26.970  INFO connection{addr=127.0.0.1:41060}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:26.970  INFO connection{addr=127.0.0.1:41060}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:26.971  INFO connection{addr=127.0.0.1:41060}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:26.971  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:29.139  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:29.142  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:29.144  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:29.145  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:29.145  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:29.145  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:29.145  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:29.150  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:29.152  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:29.153  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:29.153  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:29.154  INFO connection{addr=127.0.0.1:44346}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:29.154  INFO connection{addr=127.0.0.1:44348}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:29.155  WARN connection{addr=127.0.0.1:44346}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:29.155  INFO connection{addr=127.0.0.1:44346}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:29.155  WARN connection{addr=127.0.0.1:44348}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:29.156  INFO connection{addr=127.0.0.1:44348}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:29.156  INFO connection{addr=127.0.0.1:44334}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:29.156  INFO connection{addr=127.0.0.1:44346}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:29.156  INFO connection{addr=127.0.0.1:44340}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:29.157  INFO connection{addr=127.0.0.1:44348}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:29.157  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:29.157  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:29.158  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:29.162  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.162  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:29.163  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.188  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:29.216  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:29.216  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:29.217  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:29.217  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:29.218  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:29.220  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:29.221  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:29.222  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:29.223  INFO connection{addr=127.0.0.1:41084}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:29.224  INFO connection{addr=127.0.0.1:41086}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:29.224  WARN connection{addr=127.0.0.1:41084}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:29.225  INFO connection{addr=127.0.0.1:41084}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:29.225  WARN connection{addr=127.0.0.1:41086}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:29.225  INFO connection{addr=127.0.0.1:41086}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:29.226  INFO connection{addr=127.0.0.1:41060}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:29.226  INFO connection{addr=127.0.0.1:41060}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:29.227  INFO connection{addr=127.0.0.1:41042}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:29.227  INFO connection{addr=127.0.0.1:41042}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:29.228  INFO connection{addr=127.0.0.1:41060}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:29.229  INFO connection{addr=127.0.0.1:41084}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:29.229  INFO connection{addr=127.0.0.1:41042}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:29.230  INFO connection{addr=127.0.0.1:41086}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:29.230  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:29.231  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:29.231  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.232  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.232  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.233  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.234  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.234  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.235  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.235  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.235  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.236  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.236  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.237  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.237  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.237  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.238  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:29.238  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.152  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:30.155  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:30.158  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:30.158  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:30.158  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:30.158  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:30.158  INFO connection{addr=127.0.0.1:44348}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:30.159  INFO connection{addr=127.0.0.1:44346}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:30.159  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:30.159 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 523.346969ms... [INFO] [stdout] May 05 02:12:30.160  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:30.160  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.160 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 491.45308ms... [INFO] [stdout] May 05 02:12:30.160  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:30.161  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.163  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:30.163  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:30.220  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:30.257  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:30.293  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:30.293  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:30.293  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:30.293  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:30.293  INFO connection{addr=127.0.0.1:41084}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:30.294  INFO connection{addr=127.0.0.1:41084}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:30.294  INFO connection{addr=127.0.0.1:41086}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:30.294  INFO connection{addr=127.0.0.1:41086}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:30.294  INFO connection{addr=127.0.0.1:41084}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:30.294  INFO connection{addr=127.0.0.1:41086}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:30.295  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:30.295 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 479.035475ms... [INFO] [stdout] May 05 02:12:30.295 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 494.610889ms... [INFO] [stdout] May 05 02:12:30.296  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.296  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.296  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.296  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.296  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.297  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.297  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.297  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.297  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.298  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.298  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.298  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.299  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.299  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.299  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.299  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:30.302  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:30.302  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:30.654  INFO connection{addr=127.0.0.1:44360}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:30.655  INFO connection{addr=127.0.0.1:44360}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:30.655  INFO connection{addr=127.0.0.1:44360}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:30.656  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:30.685  INFO connection{addr=127.0.0.1:44366}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:30.686  INFO connection{addr=127.0.0.1:44366}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:30.686  INFO connection{addr=127.0.0.1:44366}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:30.687  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:30.776  INFO connection{addr=127.0.0.1:41128}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:30.777  INFO connection{addr=127.0.0.1:41128}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:30.777  INFO connection{addr=127.0.0.1:41128}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:30.778  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:30.792  INFO connection{addr=127.0.0.1:41148}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:30.793  INFO connection{addr=127.0.0.1:41148}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:30.794  INFO connection{addr=127.0.0.1:41148}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:30.794  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:32.660  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:32.666  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:32.667  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:32.667  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:32.667  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:32.667  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:32.667  INFO connection{addr=127.0.0.1:44360}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:32.668  INFO connection{addr=127.0.0.1:44366}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:32.668  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:32.668  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:32.668  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] May 05 02:12:32.669  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:32.669  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.669  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:32.670  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.678  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:32.708  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:32.709  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:32.709 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 542.374848ms... [INFO] [stdout] May 05 02:12:32.710 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 530.227942ms... [INFO] [stdout] May 05 02:12:32.797  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:32.898  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:32.898  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:32.898  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:32.899  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:32.899  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:32.899  INFO connection{addr=127.0.0.1:41128}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:32.900  INFO connection{addr=127.0.0.1:41128}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:32.900  INFO connection{addr=127.0.0.1:41148}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:32.900  INFO connection{addr=127.0.0.1:41148}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:32.900  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:32.901  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:32.901  INFO connection{addr=127.0.0.1:41128}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:32.901  INFO connection{addr=127.0.0.1:41148}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:32.902  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] May 05 02:12:32.903  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.903  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.903  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.904  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.904  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.904  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.905  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.905  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.905  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.906  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.906  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.907  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.907  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.907  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.908  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.908  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:32.914  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:32.924  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:32.924  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:32.925 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 536.942753ms... [INFO] [stdout] May 05 02:12:32.926 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 537.664101ms... [INFO] [stdout] May 05 02:12:33.242 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 768.819568ms... [INFO] [stdout] May 05 02:12:33.254 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 811.510961ms... [INFO] [stdout] May 05 02:12:33.464 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 795.049844ms... [INFO] [stdout] May 05 02:12:33.465 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 796.830152ms... [INFO] [stdout] May 05 02:12:33.670  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] May 05 02:12:33.672  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:33.688  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:33.903  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] May 05 02:12:33.907  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:33.911  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:34.026  INFO connection{addr=127.0.0.1:44382}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:34.027  INFO connection{addr=127.0.0.1:44382}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:34.027  INFO connection{addr=127.0.0.1:44382}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:34.028  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:34.078  INFO connection{addr=127.0.0.1:44388}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:34.078  INFO connection{addr=127.0.0.1:44388}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:34.079  INFO connection{addr=127.0.0.1:44388}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:34.079  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:34.283  INFO connection{addr=127.0.0.1:41186}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:34.286  INFO connection{addr=127.0.0.1:41186}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:34.287  INFO connection{addr=127.0.0.1:41186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:34.287  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:34.288  INFO connection{addr=127.0.0.1:41188}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:34.291  INFO connection{addr=127.0.0.1:41188}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:34.300  INFO connection{addr=127.0.0.1:41188}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:34.301  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:36.171  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:36.174  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:36.176  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:36.176  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:36.176  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:36.177  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:36.177  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:36.178  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:36.187  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:36.187  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:36.204  INFO connection{addr=127.0.0.1:44396}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:36.209  WARN connection{addr=127.0.0.1:44396}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:36.209  INFO connection{addr=127.0.0.1:44396}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:36.210  INFO connection{addr=127.0.0.1:44382}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:36.210  INFO connection{addr=127.0.0.1:44396}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:36.210  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:36.211  INFO connection{addr=127.0.0.1:44398}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:36.211  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:36.211  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.212  WARN connection{addr=127.0.0.1:44398}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:36.213  INFO connection{addr=127.0.0.1:44398}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:36.220  INFO connection{addr=127.0.0.1:44388}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:36.220  INFO connection{addr=127.0.0.1:44398}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:36.220  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:36.221  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:36.222  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.404  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:36.469  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:36.520  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:36.521  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:36.521  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:36.522  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:36.522  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:36.530  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:36.540  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:36.540  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:36.563  INFO connection{addr=127.0.0.1:41228}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:36.566  WARN connection{addr=127.0.0.1:41228}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:36.566  INFO connection{addr=127.0.0.1:41228}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:36.567  INFO connection{addr=127.0.0.1:41188}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:36.567  INFO connection{addr=127.0.0.1:41188}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:36.568  INFO connection{addr=127.0.0.1:41188}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:36.568  INFO connection{addr=127.0.0.1:41228}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:36.569  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:36.569  INFO connection{addr=127.0.0.1:41230}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:36.570  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.570  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.571  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.571  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.571  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.572  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.572  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.573  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.577  WARN connection{addr=127.0.0.1:41230}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:36.577  INFO connection{addr=127.0.0.1:41230}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:36.586  INFO connection{addr=127.0.0.1:41186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:36.586  INFO connection{addr=127.0.0.1:41186}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:36.587  INFO connection{addr=127.0.0.1:41186}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:36.588  INFO connection{addr=127.0.0.1:41230}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:36.588  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:36.590  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.591  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.591  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.591  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.592  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.592  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.593  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:36.594  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.178  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:37.223  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:37.226  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:37.226  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:37.226  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:37.226  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:37.227  INFO connection{addr=127.0.0.1:44396}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:37.227  INFO connection{addr=127.0.0.1:44398}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:37.227  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:37.228 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 530.461646ms... [INFO] [stdout] May 05 02:12:37.228  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:37.228  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.229 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 508.89768ms... [INFO] [stdout] May 05 02:12:37.229  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:37.229  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.237  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:37.241  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:37.524  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:37.585  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:37.636  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:37.637  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:37.638  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:37.638  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:37.639  INFO connection{addr=127.0.0.1:41228}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:37.639  INFO connection{addr=127.0.0.1:41228}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:37.639  INFO connection{addr=127.0.0.1:41230}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:37.640  INFO connection{addr=127.0.0.1:41230}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:37.640  INFO connection{addr=127.0.0.1:41228}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:37.641  INFO connection{addr=127.0.0.1:41230}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:37.642  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:37.643 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 497.41763ms... [INFO] [stdout] May 05 02:12:37.644 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 535.369623ms... [INFO] [stdout] May 05 02:12:37.645  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.645  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.646  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.646  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.647  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.647  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.648  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.648  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.649  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.649  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.649  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.650  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.650  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.651  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.651  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.652  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:37.655  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:37.659  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:37.753  INFO connection{addr=127.0.0.1:44410}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:37.754  INFO connection{addr=127.0.0.1:44410}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:37.754  INFO connection{addr=127.0.0.1:44410}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:37.754  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:37.783  INFO connection{addr=127.0.0.1:44416}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:37.784  INFO connection{addr=127.0.0.1:44416}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:37.784  INFO connection{addr=127.0.0.1:44416}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:37.784  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:38.156  INFO connection{addr=127.0.0.1:41272}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:38.156  INFO connection{addr=127.0.0.1:41272}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:38.157  INFO connection{addr=127.0.0.1:41272}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:38.157  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:38.273  INFO connection{addr=127.0.0.1:41292}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:38.274  INFO connection{addr=127.0.0.1:41292}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:38.275  INFO connection{addr=127.0.0.1:41292}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:38.275  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:39.729  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:39.736  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:39.736  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:39.736  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:39.736  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:39.736  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:39.736  INFO connection{addr=127.0.0.1:44410}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:39.737  INFO connection{addr=127.0.0.1:44416}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:39.737  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:39.738  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:39.738  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the client [INFO] [stdout] May 05 02:12:39.738  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:39.739  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:39.739  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:39.739  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:39.746  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:39.747  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:39.747  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:39.748 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 452.045162ms... [INFO] [stdout] May 05 02:12:39.748 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 475.953311ms... [INFO] [stdout] May 05 02:12:40.145  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:40.202 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 721.95577ms... [INFO] [stdout] May 05 02:12:40.226 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 722.070746ms... [INFO] [stdout] May 05 02:12:40.307  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:40.307  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:40.308  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:40.308  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:40.308  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:40.309  INFO connection{addr=127.0.0.1:41272}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:40.309  INFO connection{addr=127.0.0.1:41272}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:40.309  INFO connection{addr=127.0.0.1:41292}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:40.310  INFO connection{addr=127.0.0.1:41292}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:40.310  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:40.311  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:40.311  INFO connection{addr=127.0.0.1:41272}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:40.311  INFO connection{addr=127.0.0.1:41292}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:40.312  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the client [INFO] [stdout] May 05 02:12:40.313  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.314  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.314  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.315  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.315  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.315  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.316  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.316  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.317  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.317  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.318  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.318  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.319  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.319  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.320  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.320  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:40.330  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:40.332  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:40.332  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:40.335 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 530.9454ms... [INFO] [stdout] May 05 02:12:40.336 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 494.753172ms... [INFO] [stdout] May 05 02:12:40.739  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the server [INFO] [stdout] May 05 02:12:40.741  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:40.742  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:40.837 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 799.309011ms... [INFO] [stdout] May 05 02:12:40.869 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 744.644161ms... [INFO] [stdout] May 05 02:12:40.936  INFO connection{addr=127.0.0.1:44430}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:40.937  INFO connection{addr=127.0.0.1:44430}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:40.937  INFO connection{addr=127.0.0.1:44430}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:40.942  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:40.988  INFO connection{addr=127.0.0.1:44436}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:40.989  INFO connection{addr=127.0.0.1:44436}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:40.990  INFO connection{addr=127.0.0.1:44436}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:40.990  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:41.313  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the server [INFO] [stdout] May 05 02:12:41.316  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:41.316  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:41.627  INFO connection{addr=127.0.0.1:41328}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:41.628  INFO connection{addr=127.0.0.1:41328}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:41.629  INFO connection{addr=127.0.0.1:41328}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:41.629  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:41.726  INFO connection{addr=127.0.0.1:41348}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:41.726  INFO connection{addr=127.0.0.1:41348}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:41.727  INFO connection{addr=127.0.0.1:41348}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:41.728  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:43.241  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:43.247  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:43.294  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:43.294  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:43.295  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:43.295  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:43.295  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:43.300  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:43.301  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:43.302  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:43.323  INFO connection{addr=127.0.0.1:44442}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:43.326  INFO connection{addr=127.0.0.1:44444}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:43.327  WARN connection{addr=127.0.0.1:44442}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:43.329  INFO connection{addr=127.0.0.1:44442}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:43.330  INFO connection{addr=127.0.0.1:44430}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:43.330  INFO connection{addr=127.0.0.1:44442}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:43.331  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:43.331  WARN connection{addr=127.0.0.1:44444}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:43.332  INFO connection{addr=127.0.0.1:44444}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:43.332  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:43.333  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:43.333  INFO connection{addr=127.0.0.1:44436}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:43.334  INFO connection{addr=127.0.0.1:44444}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:43.334  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:43.343  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:43.343  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:43.815  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:43.974  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:44.044  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the client [INFO] [stdout] May 05 02:12:44.044  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:44.045  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:44.045  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:44.045  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the client [INFO] [stdout] May 05 02:12:44.053  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:44.055  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d [INFO] [stdout] May 05 02:12:44.055  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b [INFO] [stdout] May 05 02:12:44.073  INFO connection{addr=127.0.0.1:41372}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:44.075  INFO connection{addr=127.0.0.1:41374}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:44.075  WARN connection{addr=127.0.0.1:41372}: rathole::server: Dropping previous control channel for service echo [INFO] [stdout] May 05 02:12:44.075  INFO connection{addr=127.0.0.1:41372}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:44.076  INFO connection{addr=127.0.0.1:41328}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:44.076  INFO connection{addr=127.0.0.1:41328}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:44.077  INFO connection{addr=127.0.0.1:41328}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:44.077  INFO connection{addr=127.0.0.1:41372}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:44.078  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:44.078  WARN connection{addr=127.0.0.1:41374}: rathole::server: Dropping previous control channel for service pingpong [INFO] [stdout] May 05 02:12:44.079  INFO connection{addr=127.0.0.1:41374}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:44.079  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.079  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.079  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.080  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.080  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.080  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.080  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.081  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.081  INFO connection{addr=127.0.0.1:41348}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:44.081  INFO connection{addr=127.0.0.1:41348}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:44.082  INFO connection{addr=127.0.0.1:41348}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:44.083  INFO connection{addr=127.0.0.1:41374}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:44.083  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:44.109  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.110  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.110  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.110  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.111  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.111  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.111  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.111  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.297  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo [INFO] [stdout] May 05 02:12:44.344  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:44.390  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:44.390  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:44.391  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:44.391  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:44.391  INFO connection{addr=127.0.0.1:44444}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:44.392  INFO connection{addr=127.0.0.1:44442}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:44.392  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:44.392 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 488.659906ms... [INFO] [stdout] May 05 02:12:44.392  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:44.393  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.393 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 528.072451ms... [INFO] [stdout] May 05 02:12:44.393  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file [INFO] [stdout] May 05 02:12:44.393  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:44.395  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:44.395  INFO rathole::server: Listening at 0.0.0.0:2332 [INFO] [stdout] May 05 02:12:44.892  INFO connection{addr=127.0.0.1:44454}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:44.892  INFO connection{addr=127.0.0.1:44454}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:44.892  INFO connection{addr=127.0.0.1:44454}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:44.893  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:44.931  INFO connection{addr=127.0.0.1:44462}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:44.931  INFO connection{addr=127.0.0.1:44462}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:44.932  INFO connection{addr=127.0.0.1:44462}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:44.932  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:45.047  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo [INFO] [stdout] May 05 02:12:45.191  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong [INFO] [stdout] May 05 02:12:45.498  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server [INFO] [stdout] May 05 02:12:45.498  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:45.498  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:45.498  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:45.499  INFO connection{addr=127.0.0.1:41374}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:45.499  INFO connection{addr=127.0.0.1:41374}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:45.499  INFO connection{addr=127.0.0.1:41372}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:45.499  INFO connection{addr=127.0.0.1:41372}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:45.499  INFO connection{addr=127.0.0.1:41374}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:45.500  INFO connection{addr=127.0.0.1:41372}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:45.500  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the server [INFO] [stdout] May 05 02:12:45.501 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 485.429466ms... [INFO] [stdout] May 05 02:12:45.501 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 459.860947ms... [INFO] [stdout] May 05 02:12:45.501  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.502  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.502  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.502  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.502  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.502  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.503  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.503  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.503  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.503  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.503  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.504  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.504  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.504  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.504  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.505  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof [INFO] [stdout] May 05 02:12:45.514  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config [INFO] [stdout] May 05 02:12:45.514  INFO rathole::server: Listening at 0.0.0.0:2333 [INFO] [stdout] May 05 02:12:45.972  INFO connection{addr=127.0.0.1:41416}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:45.973  INFO connection{addr=127.0.0.1:41416}: rathole::server: Control channel established service=echo [INFO] [stdout] May 05 02:12:45.974  INFO connection{addr=127.0.0.1:41416}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334 [INFO] [stdout] May 05 02:12:45.974  INFO handle{service=echo}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:46.055  INFO connection{addr=127.0.0.1:41434}: rathole::server: Try to handshake a control channel [INFO] [stdout] May 05 02:12:46.056  INFO connection{addr=127.0.0.1:41434}: rathole::server: Control channel established service=pingpong [INFO] [stdout] May 05 02:12:46.057  INFO connection{addr=127.0.0.1:41434}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335 [INFO] [stdout] May 05 02:12:46.057  INFO handle{service=pingpong}:run: rathole::client: Control channel established [INFO] [stdout] May 05 02:12:46.893  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:46.990  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:46.990  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:46.990  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:46.991  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:46.991  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:46.991  INFO connection{addr=127.0.0.1:44454}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:46.991  INFO connection{addr=127.0.0.1:44462}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:46.992  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:46.992  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] test udp ... ok [INFO] [stdout] May 05 02:12:48.001  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong [INFO] [stdout] May 05 02:12:48.382  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server and the client [INFO] [stdout] May 05 02:12:48.383  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:48.383  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting [INFO] [stdout] May 05 02:12:48.383  INFO rathole::server: Shuting down gracefully... [INFO] [stdout] May 05 02:12:48.383  INFO rathole::server: Shutdown [INFO] [stdout] May 05 02:12:48.383  INFO connection{addr=127.0.0.1:41434}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:48.384  INFO connection{addr=127.0.0.1:41434}:handle{service=pingpong}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:48.384  INFO connection{addr=127.0.0.1:41416}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown [INFO] [stdout] May 05 02:12:48.384  INFO connection{addr=127.0.0.1:41416}:handle{service=echo}:run: rathole::server: Control channel shutdown [INFO] [stdout] May 05 02:12:48.384  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:48.384  INFO handle{service=echo}:run: rathole::client: Control channel shutdown [INFO] [stdout] May 05 02:12:48.385  INFO connection{addr=127.0.0.1:41434}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown [INFO] [stdout] May 05 02:12:48.385  INFO connection{addr=127.0.0.1:41416}: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.77s [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" "d19d661e21d189cfcbdb3233f27ec5d70252a1cc4974331ef4e5d3cb9ebce21b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d19d661e21d189cfcbdb3233f27ec5d70252a1cc4974331ef4e5d3cb9ebce21b", kill_on_drop: false }` [INFO] [stdout] d19d661e21d189cfcbdb3233f27ec5d70252a1cc4974331ef4e5d3cb9ebce21b