[INFO] cloning repository https://github.com/rohankumardubey/rathole
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rohankumardubey/rathole" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Frathole", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Frathole'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 8a247238954722d4de7e83dba0cff410d62ffb14
[INFO] testing rohankumardubey/rathole against master#6c20ab744b0f82646d90ce9d25894823abc9c669 for pr-99093
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Frathole" "/workspace/builds/worker-0/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/rohankumardubey/rathole on toolchain 6c20ab744b0f82646d90ce9d25894823abc9c669
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/rohankumardubey/rathole
[INFO] finished tweaking git repo https://github.com/rohankumardubey/rathole
[INFO] tweaked toml for git repo https://github.com/rohankumardubey/rathole written to /workspace/builds/worker-0/source/Cargo.toml
[INFO] crate git repo https://github.com/rohankumardubey/rathole already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded snowstorm v0.3.1
[INFO] [stderr]   Downloaded async-http-proxy v1.2.5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 888b714561a78811202e10c9655e13430f6c314a28194682f7c28847f0f3f36e
[INFO] running `Command { std: "docker" "start" "-a" "888b714561a78811202e10c9655e13430f6c314a28194682f7c28847f0f3f36e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "888b714561a78811202e10c9655e13430f6c314a28194682f7c28847f0f3f36e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "888b714561a78811202e10c9655e13430f6c314a28194682f7c28847f0f3f36e", kill_on_drop: false }`
[INFO] [stdout] 888b714561a78811202e10c9655e13430f6c314a28194682f7c28847f0f3f36e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 0b4040639d219ff07d4bc73876187953d79da3376a1ae2ce7d8ff8fb6851df71
[INFO] running `Command { std: "docker" "start" "-a" "0b4040639d219ff07d4bc73876187953d79da3376a1ae2ce7d8ff8fb6851df71", 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 smallvec v1.8.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.8
[INFO] [stderr]    Compiling parking_lot_core v0.9.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling rustversion v1.0.6
[INFO] [stderr]    Compiling bitflags v1.3.2
[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 futures-core v0.3.21
[INFO] [stderr]    Compiling ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling openssl v0.10.38
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling futures-task v0.3.21
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling httparse v1.6.0
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling async-trait v0.1.52
[INFO] [stderr]    Compiling native-tls v0.2.8
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling slab v0.4.5
[INFO] [stderr]    Compiling openssl-probe v0.1.5
[INFO] [stderr]    Compiling ryu v1.0.9
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling tracing-core v0.1.23
[INFO] [stderr]    Compiling sharded-slab v0.1.4
[INFO] [stderr]    Compiling thread_local v1.1.4
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling lock_api v0.4.6
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[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 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 walkdir v2.3.2
[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 semver-parser v0.10.2
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling mio v0.8.0
[INFO] [stderr]    Compiling num_cpus v1.13.1
[INFO] [stderr]    Compiling socket2 v0.4.4
[INFO] [stderr]    Compiling getrandom v0.2.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[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 mio v0.7.14
[INFO] [stderr]    Compiling fdlimit v0.2.1
[INFO] [stderr]    Compiling jobserver v0.1.24
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling parking_lot v0.12.0
[INFO] [stderr]    Compiling semver v0.11.0
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling inotify v0.9.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling cc v1.0.73
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling regex v1.5.5
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling rustc_version v0.3.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling notify v5.0.0-pre.13
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling universal-hash v0.4.1
[INFO] [stderr]    Compiling cipher v0.3.0
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling aead v0.4.3
[INFO] [stderr]    Compiling crypto-mac v0.8.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling 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 url v2.2.2
[INFO] [stderr]    Compiling ctr v0.8.0
[INFO] [stderr]    Compiling aes v0.7.5
[INFO] [stderr]    Compiling blake2 v0.9.2
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling digest v0.10.3
[INFO] [stderr]    Compiling matchers v0.0.1
[INFO] [stderr]    Compiling ghash v0.4.4
[INFO] [stderr]    Compiling sha2 v0.10.2
[INFO] [stderr]    Compiling aes-gcm v0.9.4
[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 vergen v6.0.2
[INFO] [stderr]    Compiling synstructure v0.12.6
[INFO] [stderr]    Compiling git2 v0.14.1
[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 pin-project-internal v1.0.10
[INFO] [stderr]    Compiling tracing-attributes v0.1.20
[INFO] [stderr]    Compiling futures-macro v0.3.21
[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 rathole v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling clap v3.1.6
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling tracing-serde v0.1.3
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling tokio v1.17.0
[INFO] [stderr]    Compiling tracing-subscriber v0.2.25
[INFO] [stderr]    Compiling async-http-proxy v1.2.5
[INFO] [stderr]    Compiling snowstorm v0.3.1
[INFO] [stderr]    Compiling async-socks5 v0.5.1
[INFO] [stderr]    Compiling tokio-native-tls v0.3.0
[INFO] [stderr]    Compiling backoff v0.4.0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4m 13s
[INFO] running `Command { std: "docker" "inspect" "0b4040639d219ff07d4bc73876187953d79da3376a1ae2ce7d8ff8fb6851df71", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0b4040639d219ff07d4bc73876187953d79da3376a1ae2ce7d8ff8fb6851df71", kill_on_drop: false }`
[INFO] [stdout] 0b4040639d219ff07d4bc73876187953d79da3376a1ae2ce7d8ff8fb6851df71
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 424dd365e2630297ede60c767a8e83dbc003c86f91f59bf7cc17f6da4762a960
[INFO] running `Command { std: "docker" "start" "-a" "424dd365e2630297ede60c767a8e83dbc003c86f91f59bf7cc17f6da4762a960", kill_on_drop: false }`
[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 lazy_static v1.4.0
[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 ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling slab v0.4.5
[INFO] [stderr]    Compiling ryu v1.0.9
[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 hashbrown v0.11.2
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling strsim v0.10.0
[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 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 tracing-core v0.1.23
[INFO] [stderr]    Compiling sharded-slab v0.1.4
[INFO] [stderr]    Compiling thread_local v1.1.4
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling typenum v1.15.0
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling futures-core v0.3.21
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling futures-task v0.3.21
[INFO] [stderr]    Compiling httparse v1.6.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.1
[INFO] [stderr]    Compiling num_cpus v1.13.1
[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 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 fdlimit v0.2.1
[INFO] [stderr]    Compiling mio v0.8.0
[INFO] [stderr]    Compiling mio v0.7.14
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling tracing-log v0.1.2
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling inotify v0.9.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling parking_lot v0.12.0
[INFO] [stderr]    Compiling crossbeam-channel v0.5.2
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling pin-project v1.0.10
[INFO] [stderr]    Compiling tracing v0.1.31
[INFO] [stderr]    Compiling openssl-sys v0.9.72
[INFO] [stderr]    Compiling zeroize v1.3.0
[INFO] [stderr]    Compiling generic-array v0.14.5
[INFO] [stderr]    Compiling clap v3.1.6
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling notify v5.0.0-pre.13
[INFO] [stderr]    Compiling openssl v0.10.38
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling regex v1.5.5
[INFO] [stderr]    Compiling universal-hash v0.4.1
[INFO] [stderr]    Compiling cipher v0.3.0
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling aead v0.4.3
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling crypto-mac v0.8.0
[INFO] [stderr]    Compiling crypto-common v0.1.3
[INFO] [stderr]    Compiling block-buffer v0.10.2
[INFO] [stderr]    Compiling polyval v0.5.3
[INFO] [stderr]    Compiling poly1305 v0.7.2
[INFO] [stderr]    Compiling curve25519-dalek v3.2.1
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling ctr v0.8.0
[INFO] [stderr]    Compiling aes v0.7.5
[INFO] [stderr]    Compiling chacha20 v0.7.3
[INFO] [stderr]    Compiling blake2 v0.9.2
[INFO] [stderr]    Compiling digest v0.10.3
[INFO] [stderr]    Compiling ghash v0.4.4
[INFO] [stderr]    Compiling chacha20poly1305 v0.8.2
[INFO] [stderr]    Compiling aes-gcm v0.9.4
[INFO] [stderr]    Compiling sha2 v0.10.2
[INFO] [stderr]    Compiling x25519-dalek v1.2.0
[INFO] [stderr]    Compiling matchers v0.0.1
[INFO] [stderr]    Compiling snow v0.8.0
[INFO] [stderr]    Compiling native-tls v0.2.8
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling tracing-serde v0.1.3
[INFO] [stderr]    Compiling url v2.2.2
[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 async-socks5 v0.5.1
[INFO] [stderr]    Compiling snowstorm v0.3.1
[INFO] [stderr]    Compiling backoff v0.4.0
[INFO] [stderr]    Compiling tokio-native-tls v0.3.0
[INFO] [stderr]    Compiling async-http-proxy v1.2.5
[INFO] [stderr]    Compiling rathole v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2m 18s
[INFO] running `Command { std: "docker" "inspect" "424dd365e2630297ede60c767a8e83dbc003c86f91f59bf7cc17f6da4762a960", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "424dd365e2630297ede60c767a8e83dbc003c86f91f59bf7cc17f6da4762a960", kill_on_drop: false }`
[INFO] [stdout] 424dd365e2630297ede60c767a8e83dbc003c86f91f59bf7cc17f6da4762a960
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+6c20ab744b0f82646d90ce9d25894823abc9c669" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 8eeca7629b064c78741c87fd89ddbbbc728d8686570b9d94c792788a8cb5b5b0
[INFO] running `Command { std: "docker" "start" "-a" "8eeca7629b064c78741c87fd89ddbbbc728d8686570b9d94c792788a8cb5b5b0", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.50s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rathole-a4d338eabfca104e)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test config::tests::test_validate_server_config ... ok
[INFO] [stdout] test tests::test_determine_run_mode ... ok
[INFO] [stdout] test config::tests::test_validate_client_config ... ok
[INFO] [stdout] test config::tests::test_example_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 config::tests::test_invalid_config ... ok
[INFO] [stdout] test config::tests::test_valid_config ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-946f1e482d5da1cc)
[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] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] Jul 22 19:00:38.469  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:38.470  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:38.489  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:38.489  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:38.489  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:38.490 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 473.719747ms...
[INFO] [stdout] Jul 22 19:00:38.490 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 531.563775ms...
[INFO] [stdout] Jul 22 19:00:38.513  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:38.513  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:38.513  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:38.514 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 549.392367ms...
[INFO] [stdout] Jul 22 19:00:38.514 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 471.804235ms...
[INFO] [stdout] Jul 22 19:00:38.966 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 730.236549ms...
[INFO] [stdout] Jul 22 19:00:38.988 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 765.036341ms...
[INFO] [stdout] Jul 22 19:00:39.024 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 774.914616ms...
[INFO] [stdout] Jul 22 19:00:39.066 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 710.875187ms...
[INFO] [stdout] Jul 22 19:00:39.487  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:39.488  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:39.489  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:39.489  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:39.491  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:39.491  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:39.698  INFO connection{addr=127.0.0.1:50564}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:39.698  INFO connection{addr=127.0.0.1:50564}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:39.699  INFO connection{addr=127.0.0.1:50564}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:39.699  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:39.755  INFO connection{addr=127.0.0.1:60678}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:39.755  INFO connection{addr=127.0.0.1:60678}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:39.756  INFO connection{addr=127.0.0.1:60678}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:39.756  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:39.779  INFO connection{addr=127.0.0.1:60696}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:39.780  INFO connection{addr=127.0.0.1:60696}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:39.780  INFO connection{addr=127.0.0.1:60696}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:39.780  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:39.838  INFO connection{addr=127.0.0.1:50598}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:39.838  INFO connection{addr=127.0.0.1:50598}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:39.838  INFO connection{addr=127.0.0.1:50598}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:39.839  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:41.988  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:41.991  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:41.993  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:41.993  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:41.993  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:41.993  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:41.993  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:41.994  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:42.005  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:42.005  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:42.005  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:42.006  INFO connection{addr=127.0.0.1:50618}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:42.006  INFO connection{addr=127.0.0.1:50620}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:42.007  WARN connection{addr=127.0.0.1:50618}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:42.007  INFO connection{addr=127.0.0.1:50618}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:42.007  WARN connection{addr=127.0.0.1:50620}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:42.007  INFO connection{addr=127.0.0.1:50620}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:42.007  INFO connection{addr=127.0.0.1:50598}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.008  INFO connection{addr=127.0.0.1:50618}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:42.008  INFO connection{addr=127.0.0.1:50564}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.008  INFO connection{addr=127.0.0.1:50620}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:42.008  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:42.009  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:42.009  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:42.009  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.009  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:42.009  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.050  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:42.076  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:42.081  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:42.081  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.081  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.082  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:42.089  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:42.089  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:42.089  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:42.090  INFO connection{addr=127.0.0.1:60744}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:42.091  INFO connection{addr=127.0.0.1:60746}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:42.091  WARN connection{addr=127.0.0.1:60744}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:42.091  INFO connection{addr=127.0.0.1:60744}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:42.092  WARN connection{addr=127.0.0.1:60746}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:42.092  INFO connection{addr=127.0.0.1:60746}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:42.092  INFO connection{addr=127.0.0.1:60696}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:42.092  INFO connection{addr=127.0.0.1:60696}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.092  INFO connection{addr=127.0.0.1:60678}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:42.093  INFO connection{addr=127.0.0.1:60678}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:42.093  INFO connection{addr=127.0.0.1:60696}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:42.093  INFO connection{addr=127.0.0.1:60744}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:42.094  INFO connection{addr=127.0.0.1:60678}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:42.094  INFO connection{addr=127.0.0.1:60746}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:42.094  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:42.094  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:42.095  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.095  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.095  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.095  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.095  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.096  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.096  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.096  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.096  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.096  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.097  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.097  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.097  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.097  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.098  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.098  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:42.995  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:42.998  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:43.000  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:43.000  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:43.000  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:43.000  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:43.000  INFO connection{addr=127.0.0.1:50620}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:43.001  INFO connection{addr=127.0.0.1:50618}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:43.001  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:43.001 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 491.464215ms...
[INFO] [stdout] Jul 22 19:00:43.002  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:43.002  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.002 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 527.038132ms...
[INFO] [stdout] Jul 22 19:00:43.002  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:43.002  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.009  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:43.009  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:43.083  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:43.141  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:43.179  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:43.179  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:43.179  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:43.179  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:43.179  INFO connection{addr=127.0.0.1:60744}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:43.180  INFO connection{addr=127.0.0.1:60744}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:43.180  INFO connection{addr=127.0.0.1:60746}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:43.180  INFO connection{addr=127.0.0.1:60746}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:43.185  INFO connection{addr=127.0.0.1:60744}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:43.185  INFO connection{addr=127.0.0.1:60746}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:43.186  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:43.186 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 482.137948ms...
[INFO] [stdout] Jul 22 19:00:43.187 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 492.122276ms...
[INFO] [stdout] Jul 22 19:00:43.187  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.187  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.188  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.188  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.188  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.188  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.189  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.189  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.189  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.190  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.190  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.190  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.190  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.191  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:43.197  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:43.197  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:43.495  INFO connection{addr=127.0.0.1:50694}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:43.495  INFO connection{addr=127.0.0.1:50694}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:43.496  INFO connection{addr=127.0.0.1:50694}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:43.496  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:43.531  INFO connection{addr=127.0.0.1:50700}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:43.532  INFO connection{addr=127.0.0.1:50700}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:43.532  INFO connection{addr=127.0.0.1:50700}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:43.532  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:43.670  INFO connection{addr=127.0.0.1:60814}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:43.671  INFO connection{addr=127.0.0.1:60814}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:43.672  INFO connection{addr=127.0.0.1:60814}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:43.672  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:43.681  INFO connection{addr=127.0.0.1:60832}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:43.681  INFO connection{addr=127.0.0.1:60832}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:43.682  INFO connection{addr=127.0.0.1:60832}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:43.682  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:45.503  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:00:45.508  INFO test{config_path="tests/for_udp/tcp_transport.toml" t=Udp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:00:45.508  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:45.508  INFO config_watcher{path="tests/for_udp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:45.509  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:45.509  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:45.509  INFO connection{addr=127.0.0.1:50700}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.509  INFO connection{addr=127.0.0.1:50694}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.510  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.510  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.510  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:45.511  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:45.511  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.511  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:45.512  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.521  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:45.553  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:45.553  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:45.554 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 542.97845ms...
[INFO] [stdout] Jul 22 19:00:45.554 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 500.282303ms...
[INFO] [stdout] Jul 22 19:00:45.687  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:00:45.788  INFO test{config_path="tests/for_tcp/tcp_transport.toml" t=Tcp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:00:45.788  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:45.788  INFO config_watcher{path="tests/for_tcp/tcp_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:45.789  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:45.789  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:45.789  INFO connection{addr=127.0.0.1:60814}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:45.789  INFO connection{addr=127.0.0.1:60814}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.790  INFO connection{addr=127.0.0.1:60832}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:45.790  INFO connection{addr=127.0.0.1:60832}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.790  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.791  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:45.791  INFO connection{addr=127.0.0.1:60814}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:45.791  INFO connection{addr=127.0.0.1:60832}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:45.792  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:45.793  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.793  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.793  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.797  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.797  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.798  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.799  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.799  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.800  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.800  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.801  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.802  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.803  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.803  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.804  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.805  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:45.806  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:45.816  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:45.825  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:45.827 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 488.085096ms...
[INFO] [stdout] Jul 22 19:00:45.828 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 472.637664ms...
[INFO] [stdout] Jul 22 19:00:46.056 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 821.024335ms...
[INFO] [stdout] Jul 22 19:00:46.099 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 706.332464ms...
[INFO] [stdout] Jul 22 19:00:46.303 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 775.432687ms...
[INFO] [stdout] Jul 22 19:00:46.318 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 770.453648ms...
[INFO] [stdout] Jul 22 19:00:46.512  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:46.514  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:46.520  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:46.793  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:46.795  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:46.801  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:46.836  INFO connection{addr=127.0.0.1:50782}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:46.837  INFO connection{addr=127.0.0.1:50782}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:46.837  INFO connection{addr=127.0.0.1:50782}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:46.841  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:46.900  INFO connection{addr=127.0.0.1:50788}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:46.901  INFO connection{addr=127.0.0.1:50788}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:46.901  INFO connection{addr=127.0.0.1:50788}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:46.901  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:47.106  INFO connection{addr=127.0.0.1:60902}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:47.108  INFO connection{addr=127.0.0.1:60902}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:47.109  INFO connection{addr=127.0.0.1:60902}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:47.109  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:47.110  INFO connection{addr=127.0.0.1:60904}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:47.121  INFO connection{addr=127.0.0.1:60904}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:47.133  INFO connection{addr=127.0.0.1:60904}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:47.134  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:49.012  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:49.015  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:49.018  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:49.018  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:49.018  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.018  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.019  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:49.025  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:49.033  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:49.033  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:49.067  INFO connection{addr=127.0.0.1:50840}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:49.082  WARN connection{addr=127.0.0.1:50840}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:49.083  INFO connection{addr=127.0.0.1:50840}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:49.083  INFO connection{addr=127.0.0.1:50788}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.089  INFO connection{addr=127.0.0.1:50840}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:49.090  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:49.090  INFO connection{addr=127.0.0.1:50842}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:49.091  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:49.091  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.093  WARN connection{addr=127.0.0.1:50842}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:49.097  INFO connection{addr=127.0.0.1:50842}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:49.105  INFO connection{addr=127.0.0.1:50782}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.109  INFO connection{addr=127.0.0.1:50842}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:49.110  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:49.111  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:49.117  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.295  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:49.365  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:49.414  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:49.414  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:49.415  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.416  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.416  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:49.421  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:49.441  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:49.442  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:49.473  INFO connection{addr=127.0.0.1:60972}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:49.479  WARN connection{addr=127.0.0.1:60972}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:49.479  INFO connection{addr=127.0.0.1:60972}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:49.479  INFO connection{addr=127.0.0.1:60904}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:49.480  INFO connection{addr=127.0.0.1:60904}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.480  INFO connection{addr=127.0.0.1:60904}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:49.481  INFO connection{addr=127.0.0.1:60972}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:49.481  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:49.481  INFO connection{addr=127.0.0.1:60974}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:49.482  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.482  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.489  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.490  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.490  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.490  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.491  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.491  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.494  WARN connection{addr=127.0.0.1:60974}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:49.494  INFO connection{addr=127.0.0.1:60974}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:49.504  INFO connection{addr=127.0.0.1:60902}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:49.504  INFO connection{addr=127.0.0.1:60902}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:49.504  INFO connection{addr=127.0.0.1:60902}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:49.505  INFO connection{addr=127.0.0.1:60974}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:49.505  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:49.506  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.507  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.507  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.507  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.508  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.508  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.508  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:49.510  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.019  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:50.022  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:50.067  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:50.067  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:50.067  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:50.067  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:50.067  INFO connection{addr=127.0.0.1:50842}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:50.068  INFO connection{addr=127.0.0.1:50840}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:50.068  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:50.068 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 507.12908ms...
[INFO] [stdout] Jul 22 19:00:50.069  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:50.069  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.069 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 533.906365ms...
[INFO] [stdout] Jul 22 19:00:50.069  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:50.070  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.073  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:50.078  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:50.417  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:50.492  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:50.537  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:50.537  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:50.537  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:50.537  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:50.537  INFO connection{addr=127.0.0.1:60974}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:50.538  INFO connection{addr=127.0.0.1:60974}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:50.538  INFO connection{addr=127.0.0.1:60972}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:50.538  INFO connection{addr=127.0.0.1:60972}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:50.538  INFO connection{addr=127.0.0.1:60974}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:50.538  INFO connection{addr=127.0.0.1:60972}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:50.539  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:50.539 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 516.317719ms...
[INFO] [stdout] Jul 22 19:00:50.539 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 502.638514ms...
[INFO] [stdout] Jul 22 19:00:50.540  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.540  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.540  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.540  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.541  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.541  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.541  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.542  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.542  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.542  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.542  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.543  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.543  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.543  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.544  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.544  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:50.545  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:50.551  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:50.604  INFO connection{addr=127.0.0.1:50912}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:50.626  INFO connection{addr=127.0.0.1:50912}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:50.649  INFO connection{addr=127.0.0.1:50912}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:50.650  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:50.659  INFO connection{addr=127.0.0.1:50914}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:50.694  INFO connection{addr=127.0.0.1:50914}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:50.702  INFO connection{addr=127.0.0.1:50914}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:50.702  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:51.055  INFO connection{addr=127.0.0.1:32800}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:51.055  INFO connection{addr=127.0.0.1:32800}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:51.056  INFO connection{addr=127.0.0.1:32800}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:51.056  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:51.176  INFO connection{addr=127.0.0.1:32818}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:51.177  INFO connection{addr=127.0.0.1:32818}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:51.182  INFO connection{addr=127.0.0.1:32818}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:51.182  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:52.570  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:00:52.618  INFO test{config_path="tests/for_udp/tls_transport.toml" t=Udp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:00:52.618  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:52.618  INFO config_watcher{path="tests/for_udp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:52.618  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:52.618  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:52.619  INFO connection{addr=127.0.0.1:50914}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:52.619  INFO connection{addr=127.0.0.1:50912}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:52.619  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:52.620  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:52.620  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:52.620  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:52.621  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:52.621  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:52.621  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:52.625  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:52.626  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:52.626  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:52.627 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 543.646813ms...
[INFO] [stdout] Jul 22 19:00:52.627 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 523.013599ms...
[INFO] [stdout] Jul 22 19:00:53.040  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:00:53.152 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 800.593298ms...
[INFO] [stdout] Jul 22 19:00:53.172 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 710.203695ms...
[INFO] [stdout] Jul 22 19:00:53.212  INFO test{config_path="tests/for_tcp/tls_transport.toml" t=Tcp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:00:53.217  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:53.217  INFO config_watcher{path="tests/for_tcp/tls_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:53.217  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:53.217  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:53.218  INFO connection{addr=127.0.0.1:32800}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:53.218  INFO connection{addr=127.0.0.1:32800}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:53.218  INFO connection{addr=127.0.0.1:32818}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:53.218  INFO connection{addr=127.0.0.1:32818}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:53.218  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:53.219  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:53.219  INFO connection{addr=127.0.0.1:32800}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:53.219  INFO connection{addr=127.0.0.1:32818}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:53.220  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the client
[INFO] [stdout] Jul 22 19:00:53.221  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.222  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.222  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.222  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.222  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.223  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.223  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.223  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.224  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.224  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.224  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.224  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.225  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.225  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.225  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.226  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:53.227  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:53.228  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:53.228  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:53.230 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 484.504329ms...
[INFO] [stdout] Jul 22 19:00:53.230 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 477.506437ms...
[INFO] [stdout] Jul 22 19:00:53.622  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:53.624  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:53.624  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:53.710 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 734.926603ms...
[INFO] [stdout] Jul 22 19:00:53.715 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 753.129431ms...
[INFO] [stdout] Jul 22 19:00:53.893  INFO connection{addr=127.0.0.1:51000}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:53.894  INFO connection{addr=127.0.0.1:51000}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:53.894  INFO connection{addr=127.0.0.1:51000}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:53.895  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:53.964  INFO connection{addr=127.0.0.1:51006}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:53.965  INFO connection{addr=127.0.0.1:51006}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:53.965  INFO connection{addr=127.0.0.1:51006}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:53.966  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:54.221  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: start the server
[INFO] [stdout] Jul 22 19:00:54.223  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:54.223  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:54.455  INFO connection{addr=127.0.0.1:32888}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:54.456  INFO connection{addr=127.0.0.1:32888}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:54.457  INFO connection{addr=127.0.0.1:32888}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:54.458  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:54.570  INFO connection{addr=127.0.0.1:32906}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:54.570  INFO connection{addr=127.0.0.1:32906}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:54.572  INFO connection{addr=127.0.0.1:32906}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:54.572  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:56.124  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:56.171  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:56.222  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:56.223  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:56.223  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.223  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.223  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:56.225  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:56.226  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:56.226  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:56.246  INFO connection{addr=127.0.0.1:51056}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:56.248  INFO connection{addr=127.0.0.1:51058}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:56.249  WARN connection{addr=127.0.0.1:51056}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:56.263  INFO connection{addr=127.0.0.1:51056}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:56.264  INFO connection{addr=127.0.0.1:51000}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.264  INFO connection{addr=127.0.0.1:51056}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:56.269  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:56.270  WARN connection{addr=127.0.0.1:51058}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:56.270  INFO connection{addr=127.0.0.1:51058}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:56.271  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:56.271  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:56.272  INFO connection{addr=127.0.0.1:51006}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.272  INFO connection{addr=127.0.0.1:51058}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:56.273  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:56.280  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:56.285  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:56.722  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:56.910  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:56.985  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the client
[INFO] [stdout] Jul 22 19:00:56.985  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:56.985  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.985  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:56.985  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the client
[INFO] [stdout] Jul 22 19:00:56.993  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:56.994  INFO handle{service=echo}: rathole::client: Starting 092c79e8f80e559e404bcf660c48f3522b67aba9ff1484b0367e1a4ddef7431d
[INFO] [stdout] Jul 22 19:00:56.994  INFO handle{service=pingpong}: rathole::client: Starting c78862c4afddaa20fd3ff12e5e270480706499341ca5d1d7437ec9668556805b
[INFO] [stdout] Jul 22 19:00:57.012  INFO connection{addr=127.0.0.1:32956}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:57.019  INFO connection{addr=127.0.0.1:32958}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:57.020  WARN connection{addr=127.0.0.1:32956}: rathole::server: Dropping previous control channel for service echo
[INFO] [stdout] Jul 22 19:00:57.020  INFO connection{addr=127.0.0.1:32956}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:57.021  INFO connection{addr=127.0.0.1:32906}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:57.021  INFO connection{addr=127.0.0.1:32906}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:57.025  INFO connection{addr=127.0.0.1:32906}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:57.025  INFO connection{addr=127.0.0.1:32956}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:57.026  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:57.027  WARN connection{addr=127.0.0.1:32958}: rathole::server: Dropping previous control channel for service pingpong
[INFO] [stdout] Jul 22 19:00:57.027  INFO connection{addr=127.0.0.1:32958}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:57.028  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.028  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.028  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.029  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.029  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.029  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.029  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.030  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.030  INFO connection{addr=127.0.0.1:32888}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:57.030  INFO connection{addr=127.0.0.1:32888}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:57.031  INFO connection{addr=127.0.0.1:32888}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:57.032  INFO connection{addr=127.0.0.1:32958}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:57.032  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:57.062  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.069  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.070  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.070  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.070  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.071  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.071  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.072  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.225  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:57.230  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:57.238  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:57.239  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:57.239  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:57.239  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:57.239  INFO connection{addr=127.0.0.1:51056}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:57.240  INFO connection{addr=127.0.0.1:51058}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:57.240  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:57.240 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 510.014738ms...
[INFO] [stdout] Jul 22 19:00:57.240  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:57.241  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.241 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 539.137352ms...
[INFO] [stdout] Jul 22 19:00:57.241  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: unexpected end of file
[INFO] [stdout] Jul 22 19:00:57.241  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:57.253  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:57.253  INFO rathole::server: Listening at 0.0.0.0:2332
[INFO] [stdout] Jul 22 19:00:57.760  INFO connection{addr=127.0.0.1:51116}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:57.761  INFO connection{addr=127.0.0.1:51116}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:57.762  INFO connection{addr=127.0.0.1:51116}:handle{service=pingpong}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:57.762  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:57.796  INFO connection{addr=127.0.0.1:51122}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:57.805  INFO connection{addr=127.0.0.1:51122}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:57.806  INFO connection{addr=127.0.0.1:51122}:handle{service=echo}:run_udp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:57.807  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:57.987  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: echo
[INFO] [stdout] Jul 22 19:00:58.187  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: pingpong
[INFO] [stdout] Jul 22 19:00:58.417  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server
[INFO] [stdout] Jul 22 19:00:58.417  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:58.417  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:58.417  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:58.417  INFO connection{addr=127.0.0.1:32956}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:58.417  INFO connection{addr=127.0.0.1:32956}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:58.417  INFO connection{addr=127.0.0.1:32958}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:00:58.418  INFO connection{addr=127.0.0.1:32958}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:58.418  INFO connection{addr=127.0.0.1:32956}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:58.418  INFO connection{addr=127.0.0.1:32958}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:58.418  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: restart the server
[INFO] [stdout] Jul 22 19:00:58.419 ERROR handle{service=echo}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 452.340482ms...
[INFO] [stdout] Jul 22 19:00:58.419 ERROR handle{service=pingpong}: rathole::client: Failed to run the control channel: Failed to read cmd: early eof. Retry in 517.019978ms...
[INFO] [stdout] Jul 22 19:00:58.419  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.419  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.420  WARN handle{service=echo}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.421  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.425  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.425  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.425  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.426  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.426  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.426  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.426  WARN handle{service=pingpong}:run: rathole::client: Failed to run the data channel: Failed to read cmd: early eof
[INFO] [stdout] Jul 22 19:00:58.449  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Start watching the config
[INFO] [stdout] Jul 22 19:00:58.449  INFO rathole::server: Listening at 0.0.0.0:2333
[INFO] [stdout] Jul 22 19:00:58.881  INFO connection{addr=127.0.0.1:33018}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:58.882  INFO connection{addr=127.0.0.1:33018}: rathole::server: Control channel established service=echo
[INFO] [stdout] Jul 22 19:00:58.883  INFO connection{addr=127.0.0.1:33018}:handle{service=echo}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2334
[INFO] [stdout] Jul 22 19:00:58.883  INFO handle{service=echo}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:59.012  INFO connection{addr=127.0.0.1:33036}: rathole::server: Try to handshake a control channel
[INFO] [stdout] Jul 22 19:00:59.013  INFO connection{addr=127.0.0.1:33036}: rathole::server: Control channel established service=pingpong
[INFO] [stdout] Jul 22 19:00:59.014  INFO connection{addr=127.0.0.1:33036}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Listening at 0.0.0.0:2335
[INFO] [stdout] Jul 22 19:00:59.014  INFO handle{service=pingpong}:run: rathole::client: Control channel established
[INFO] [stdout] Jul 22 19:00:59.740  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:00:59.838  INFO test{config_path="tests/for_udp/noise_transport.toml" t=Udp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:00:59.838  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:59.838  INFO config_watcher{path="tests/for_udp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:00:59.838  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:00:59.838  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:00:59.839  INFO connection{addr=127.0.0.1:51116}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:59.839  INFO connection{addr=127.0.0.1:51122}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:59.839  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:00:59.839  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] test udp ... ok
[INFO] [stdout] Jul 22 19:01:00.920  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: lots of echo and pingpong
[INFO] [stdout] Jul 22 19:01:01.286  INFO test{config_path="tests/for_tcp/noise_transport.toml" t=Tcp}: integration_test: shutdown the server and the client
[INFO] [stdout] Jul 22 19:01:01.286  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:01:01.286  INFO config_watcher{path="tests/for_tcp/noise_transport.toml"}: rathole::config_watcher: Config watcher exiting
[INFO] [stdout] Jul 22 19:01:01.287  INFO rathole::server: Shuting down gracefully...
[INFO] [stdout] Jul 22 19:01:01.287  INFO rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:01:01.287  INFO connection{addr=127.0.0.1:33036}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:01:01.287  INFO connection{addr=127.0.0.1:33036}:handle{service=pingpong}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:01:01.287  INFO connection{addr=127.0.0.1:33018}:handle{service=echo}:run_tcp_connection_pool: rathole::server: TCPListener shutdown
[INFO] [stdout] Jul 22 19:01:01.287  INFO connection{addr=127.0.0.1:33018}:handle{service=echo}:run: rathole::server: Control channel shutdown
[INFO] [stdout] Jul 22 19:01:01.287  INFO handle{service=pingpong}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:01:01.288  INFO handle{service=echo}:run: rathole::client: Control channel shutdown
[INFO] [stdout] Jul 22 19:01:01.288  INFO connection{addr=127.0.0.1:33036}:handle{service=pingpong}:run_tcp_connection_pool: rathole::server: Shutdown
[INFO] [stdout] Jul 22 19:01:01.288  INFO connection{addr=127.0.0.1:33018}: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.85s
[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" "8eeca7629b064c78741c87fd89ddbbbc728d8686570b9d94c792788a8cb5b5b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8eeca7629b064c78741c87fd89ddbbbc728d8686570b9d94c792788a8cb5b5b0", kill_on_drop: false }`
[INFO] [stdout] 8eeca7629b064c78741c87fd89ddbbbc728d8686570b9d94c792788a8cb5b5b0