[INFO] cloning repository https://github.com/dkmstr/udstunnel
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dkmstr/udstunnel" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdkmstr%2Fudstunnel", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdkmstr%2Fudstunnel'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] be54ec0ac67b020a211fdb61dceb755a6299f499
[INFO] testing dkmstr/udstunnel against master#ebf0cf75d368c035f4c7e7246d203bd469ee4a51 for pr-137940
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdkmstr%2Fudstunnel" "/workspace/builds/worker-6-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/dkmstr/udstunnel on toolchain ebf0cf75d368c035f4c7e7246d203bd469ee4a51
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] removed /workspace/builds/worker-6-tc1/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/dkmstr/udstunnel
[INFO] finished tweaking git repo https://github.com/dkmstr/udstunnel
[INFO] tweaked toml for git repo https://github.com/dkmstr/udstunnel written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/dkmstr/udstunnel already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded aws-lc-rs v1.11.0
[INFO] [stderr]   Downloaded aws-lc-sys v0.23.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d1027d30a9b42f1827a93ad7a55ad2ecbe647a0ef542dc66b5ede7b58d440b37
[INFO] running `Command { std: "docker" "start" "-a" "d1027d30a9b42f1827a93ad7a55ad2ecbe647a0ef542dc66b5ede7b58d440b37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d1027d30a9b42f1827a93ad7a55ad2ecbe647a0ef542dc66b5ede7b58d440b37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d1027d30a9b42f1827a93ad7a55ad2ecbe647a0ef542dc66b5ede7b58d440b37", kill_on_drop: false }`
[INFO] [stdout] d1027d30a9b42f1827a93ad7a55ad2ecbe647a0ef542dc66b5ede7b58d440b37
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6fb6458415c891baa6eded6c5a87ab09f2ad2339a577654c8a96f87a7432e6e5
[INFO] running `Command { std: "docker" "start" "-a" "6fb6458415c891baa6eded6c5a87ab09f2ad2339a577654c8a96f87a7432e6e5", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.89
[INFO] [stderr]    Compiling unicode-ident v1.0.13
[INFO] [stderr]    Compiling libc v0.2.164
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling once_cell v1.20.2
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling autocfg v1.4.0
[INFO] [stderr]    Compiling serde v1.0.215
[INFO] [stderr]    Compiling smallvec v1.13.2
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling bytes v1.8.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling pin-project-lite v0.2.15
[INFO] [stderr]    Compiling itoa v1.0.11
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling dunce v1.0.5
[INFO] [stderr]    Compiling fs_extra v1.3.0
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling hashbrown v0.15.1
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling pkg-config v0.3.31
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling litemap v0.7.3
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling writeable v0.5.5
[INFO] [stderr]    Compiling crunchy v0.2.2
[INFO] [stderr]    Compiling aws-lc-rs v1.11.0
[INFO] [stderr]    Compiling tiny-keccak v2.0.2
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling http v1.1.0
[INFO] [stderr]    Compiling ahash v0.8.11
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling icu_locid_transform_data v1.5.0
[INFO] [stderr]    Compiling typenum v1.17.0
[INFO] [stderr]    Compiling httparse v1.9.5
[INFO] [stderr]    Compiling rustls-pki-types v1.10.0
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling indexmap v2.6.0
[INFO] [stderr]    Compiling lock_api v0.4.12
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling syn v2.0.87
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling jobserver v0.1.32
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling socket2 v0.5.7
[INFO] [stderr]    Compiling signal-hook-registry v1.4.2
[INFO] [stderr]    Compiling mio v1.0.2
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling cc v1.2.16
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling openssl v0.10.70
[INFO] [stderr]    Compiling allocator-api2 v0.2.20
[INFO] [stderr]    Compiling mirai-annotations v1.12.0
[INFO] [stderr]    Compiling ucd-trie v0.1.7
[INFO] [stderr]    Compiling untrusted v0.9.0
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling icu_properties_data v1.5.0
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling zeroize v1.8.1
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling const-random-macro v0.1.16
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling native-tls v0.2.12
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling utf16_iter v1.0.5
[INFO] [stderr]    Compiling write16 v1.0.0
[INFO] [stderr]    Compiling icu_normalizer_data v1.5.0
[INFO] [stderr]    Compiling rustls v0.23.18
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling ryu v1.0.18
[INFO] [stderr]    Compiling colorchoice v1.0.3
[INFO] [stderr]    Compiling anstyle-parse v0.2.6
[INFO] [stderr]    Compiling const-random v0.1.18
[INFO] [stderr]    Compiling tower-service v0.3.3
[INFO] [stderr]    Compiling anstyle v1.0.10
[INFO] [stderr]    Compiling anstyle-query v1.1.2
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling openssl-probe v0.1.5
[INFO] [stderr]    Compiling percent-encoding v2.3.1
[INFO] [stderr]    Compiling dlv-list v0.5.2
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling winnow v0.6.20
[INFO] [stderr]    Compiling webpki-roots v0.26.6
[INFO] [stderr]    Compiling form_urlencoded v1.2.1
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling anstream v0.6.18
[INFO] [stderr]    Compiling clap_lex v0.7.3
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling ordered-multimap v0.7.3
[INFO] [stderr]    Compiling cmake v0.1.51
[INFO] [stderr]    Compiling hashlink v0.8.4
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling base64 v0.21.7
[INFO] [stderr]    Compiling rust-ini v0.20.0
[INFO] [stderr]    Compiling convert_case v0.6.0
[INFO] [stderr]    Compiling clap_builder v4.5.21
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling rustls-pemfile v2.2.0
[INFO] [stderr]    Compiling http-body-util v0.1.2
[INFO] [stderr]    Compiling sync_wrapper v1.0.1
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling ipnet v2.10.1
[INFO] [stderr]    Compiling cpufeatures v0.2.15
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling pathdiff v0.2.2
[INFO] [stderr]    Compiling mime v0.3.17
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling sha2 v0.10.8
[INFO] [stderr]    Compiling uuid v1.11.0
[INFO] [stderr]    Compiling aws-lc-sys v0.23.0
[INFO] [stderr]    Compiling openssl-sys v0.9.105
[INFO] [stderr]    Compiling ring v0.17.13
[INFO] [stderr]    Compiling yaml-rust2 v0.8.1
[INFO] [stderr]    Compiling synstructure v0.13.1
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling env_filter v0.1.2
[INFO] [stderr]    Compiling env_logger v0.11.5
[INFO] [stderr]    Compiling serde_derive v1.0.215
[INFO] [stderr]    Compiling zerofrom-derive v0.1.4
[INFO] [stderr]    Compiling yoke-derive v0.7.4
[INFO] [stderr]    Compiling zerovec-derive v0.10.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio-macros v2.4.0
[INFO] [stderr]    Compiling icu_provider_macros v1.5.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling clap_derive v4.5.18
[INFO] [stderr]    Compiling async-trait v0.1.83
[INFO] [stderr]    Compiling tokio v1.41.1
[INFO] [stderr]    Compiling zerofrom v0.1.4
[INFO] [stderr]    Compiling yoke v0.7.4
[INFO] [stderr]    Compiling pest v2.7.14
[INFO] [stderr]    Compiling zerovec v0.10.4
[INFO] [stderr]    Compiling clap v4.5.21
[INFO] [stderr]    Compiling pest_meta v2.7.14
[INFO] [stderr]    Compiling tinystr v0.7.6
[INFO] [stderr]    Compiling icu_collections v1.5.0
[INFO] [stderr]    Compiling icu_locid v1.5.0
[INFO] [stderr]    Compiling pest_generator v2.7.14
[INFO] [stderr]    Compiling icu_provider v1.5.0
[INFO] [stderr]    Compiling icu_locid_transform v1.5.0
[INFO] [stderr]    Compiling pest_derive v2.7.14
[INFO] [stderr]    Compiling tokio-util v0.7.12
[INFO] [stderr]    Compiling icu_properties v1.5.1
[INFO] [stderr]    Compiling h2 v0.4.6
[INFO] [stderr]    Compiling bitflags v2.6.0
[INFO] [stderr]    Compiling serde_spanned v0.6.8
[INFO] [stderr]    Compiling toml_datetime v0.6.8
[INFO] [stderr]    Compiling json5 v0.4.1
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling ron v0.8.1
[INFO] [stderr]    Compiling toml_edit v0.22.22
[INFO] [stderr]    Compiling hyper v1.5.0
[INFO] [stderr]    Compiling icu_normalizer v1.5.0
[INFO] [stderr]    Compiling hyper-util v0.1.10
[INFO] [stderr]    Compiling idna_adapter v1.2.0
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling rustls-webpki v0.102.8
[INFO] [stderr]    Compiling url v2.5.3
[INFO] [stderr]    Compiling toml v0.8.19
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling config v0.14.1
[INFO] [stderr]    Compiling tokio-rustls v0.26.0
[INFO] [stderr]    Compiling hyper-rustls v0.27.3
[INFO] [stderr]    Compiling reqwest v0.12.9
[INFO] [stderr]    Compiling udstunnel v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 16s
[INFO] running `Command { std: "docker" "inspect" "6fb6458415c891baa6eded6c5a87ab09f2ad2339a577654c8a96f87a7432e6e5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6fb6458415c891baa6eded6c5a87ab09f2ad2339a577654c8a96f87a7432e6e5", kill_on_drop: false }`
[INFO] [stdout] 6fb6458415c891baa6eded6c5a87ab09f2ad2339a577654c8a96f87a7432e6e5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c228faca554dc5e51f88772ac25bfa3ff770e2e75c0cbca8735c6e4743c85078
[INFO] running `Command { std: "docker" "start" "-a" "c228faca554dc5e51f88772ac25bfa3ff770e2e75c0cbca8735c6e4743c85078", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.41.1
[INFO] [stderr]    Compiling mockall_derive v0.13.1
[INFO] [stderr]    Compiling predicates-core v1.0.8
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling termtree v0.4.1
[INFO] [stderr]    Compiling fragile v2.0.0
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling predicates v3.1.2
[INFO] [stderr]    Compiling predicates-tree v1.0.11
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling mockall v0.13.1
[INFO] [stderr]    Compiling tokio-util v0.7.12
[INFO] [stderr]    Compiling tokio-rustls v0.26.0
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling tokio-stream v0.1.16
[INFO] [stderr]    Compiling h2 v0.4.6
[INFO] [stderr]    Compiling tokio-test v0.4.4
[INFO] [stderr]    Compiling hyper v1.5.0
[INFO] [stderr]    Compiling hyper-util v0.1.10
[INFO] [stderr]    Compiling hyper-rustls v0.27.3
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling reqwest v0.12.9
[INFO] [stderr]    Compiling udstunnel v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 31.71s
[INFO] running `Command { std: "docker" "inspect" "c228faca554dc5e51f88772ac25bfa3ff770e2e75c0cbca8735c6e4743c85078", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c228faca554dc5e51f88772ac25bfa3ff770e2e75c0cbca8735c6e4743c85078", kill_on_drop: false }`
[INFO] [stdout] c228faca554dc5e51f88772ac25bfa3ff770e2e75c0cbca8735c6e4743c85078
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 885b917676333255e9c750b1c116899562f6bee6cacc9abcd1d5e19498ad3bf3
[INFO] running `Command { std: "docker" "start" "-a" "885b917676333255e9c750b1c116899562f6bee6cacc9abcd1d5e19498ad3bf3", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.27s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/udstunnel-c1107b7628528a56)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tunnel::types::tests::test_response_to_string ... ok
[INFO] [stdout] test tunnel::types::tests::test_command_from_str ... ok
[INFO] [stdout] test tls::crypto_provider::test_some_valid_cipher_list ... ok
[INFO] [stdout] test tls::crypto_provider::test_empty_cipher_list ... ok
[INFO] [stdout] test tls::crypto_provider::test_invalid_cipher_list ... ok
[INFO] [stdout] test tls::crypto_provider::test_valid_cipher_list ... ok
[INFO] [stdout] test tunnel::event::test_event_wakes_all_wakers ... ok
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/udstunnel-84f0ebb0af3bdf15)
[INFO] [stdout] test tunnel::event::test_event_cleans_up_wakers ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_config.rs (/opt/rustwide/target/debug/deps/test_config-80505f815cbb913c)
[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 3 tests
[INFO] [stdout] test tests::test_load_config_default ... ok
[INFO] [stdout] test tests::test_load_from_file_overrided_by_env ... ok
[INFO] [stdout] test tests::test_load_config_from_file ... ok
[INFO] [stderr]      Running tests/test_server_commands.rs (/opt/rustwide/target/debug/deps/test_server_commands-28271a5f055677b7)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr] DEBUG - udstunnel::tunnel::config 264 Configuration loaded: Config { pidfile: "/tmp/udstunnel.pid", user: "dkmaster", loglevel: "DEBUG", logfile: Some("/tmp/tunnel.log"), logsize: 125829120, lognumber: 3, listen_address: "[::]", listen_port: 7777, ipv6: true, workers: 2, ssl_min_tls_version: "1.3", ssl_certificate: "tests/certs/cert.pem", ssl_certificate_key: "tests/certs/key.pem", ssl_ciphers: "TLS_AES_256_GCM_SHA384:TLS_CHACHA20_POLY1305_SHA256:ECDHE-ECDSA-CHACHA20-POLY1305-SHA256", uds_server: "http://127.0.0.1:8000/uds/rest/tunnel/ticket", uds_token: "uds_token", uds_timeout: 4s, uds_verify_ssl: false, handshake_timeout: 1s, command_timeout: 1s, secret: "49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5", allow: ["127.0.0.1", "127.0.0.2", "::1"] }
[INFO] [stderr] DEBUG - udstunnel::tunnel::config 264 Configuration loaded: Config { pidfile: "/tmp/udstunnel.pid", user: "dkmaster", loglevel: "DEBUG", logfile: Some("/tmp/tunnel.log"), logsize: 125829120, lognumber: 3, listen_address: "[::]", listen_port: 7777, ipv6: true, workers: 2, ssl_min_tls_version: "1.3", ssl_certificate: "tests/certs/cert.pem", ssl_certificate_key: "tests/certs/key.pem", ssl_ciphers: "TLS_AES_256_GCM_SHA384:TLS_CHACHA20_POLY1305_SHA256:ECDHE-ECDSA-CHACHA20-POLY1305-SHA256", uds_server: "http://127.0.0.1:8000/uds/rest/tunnel/ticket", uds_token: "uds_token", uds_timeout: 4s, uds_verify_ssl: false, handshake_timeout: 1s, command_timeout: 1s, secret: "49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5", allow: ["127.0.0.1", "127.0.0.2", "::1"] }
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:38239
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:35333
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::config 264 Configuration loaded: Config { pidfile: "/tmp/udstunnel.pid", user: "dkmaster", loglevel: "DEBUG", logfile: Some("/tmp/tunnel.log"), logsize: 125829120, lognumber: 3, listen_address: "[::]", listen_port: 7777, ipv6: true, workers: 2, ssl_min_tls_version: "1.3", ssl_certificate: "tests/certs/cert.pem", ssl_certificate_key: "tests/certs/key.pem", ssl_ciphers: "TLS_AES_256_GCM_SHA384:TLS_CHACHA20_POLY1305_SHA256:ECDHE-ECDSA-CHACHA20-POLY1305-SHA256", uds_server: "http://127.0.0.1:8000/uds/rest/tunnel/ticket", uds_token: "uds_token", uds_timeout: 4s, uds_verify_ssl: false, handshake_timeout: 1s, command_timeout: 1s, secret: "49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5", allow: ["127.0.0.1", "127.0.0.2", "::1"] }
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:45603
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:42683
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:44897
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:35333
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:38239
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (3b150263-113b) from [::1]:37588
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:42683
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:44897
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:49292, peer: [::1]:38239, fd: 36 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (b228e584-8532) from [::1]:49292
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (b228e584-8532) from [::1]:49292
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (b228e584-8532) OPEN xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx from [::1]:49292
[INFO] [stderr] DEBUG - test_server_commands::fake::tunnel_server 49 Mocked request: ticket: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx msg: ::1 param:
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 78 UDS Response: UdsTicketResponse { host: "[::1]", port: 46211, notify: "notify_012345678901234567890123456789012" }
[INFO] [stderr] INFO - udstunnel::tunnel::relay 105 OPEN TUNNEL (b228e584-8532) FROM [::1]:49292 to [::1]:46211
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 238 Waiting for any to complete
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 146 Starting server_to_client task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 196 Starting client_to_server task
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 150 Stopping server_to_client task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 200 Stopping client_to_server task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 244 Write task completed: Ok(())
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 258 Notifying end to UDS
[INFO] [stderr] INFO - udstunnel::tunnel::relay 265 TERMINATED (b228e584-8532) [::1]:49292 to [::1]:46211, s:0, r:0, t:0
[INFO] [stderr] DEBUG - test_server_commands::fake::tunnel_server 49 Mocked request: ticket: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx msg: stop param:sent=0&recv=0&elapsed=0
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 260 End of tunnel relay
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:46748, peer: [::1]:35333, fd: 11 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stdout] test test_server_open_command ... ok
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (83001d1d-b776) from [::1]:46748
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (83001d1d-b776) from [::1]:46748
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (83001d1d-b776) UNKNOWN from [::1]:46748
[INFO] [stderr] ERROR - udstunnel::tunnel::server 306 COMMAND (83001d1d-b776) invalid from [::1]:46748: 5a4d4742a50100
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stdout] test test_invalid_command ... ok
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:44552, peer: [::1]:44897, fd: 3 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (0a166555-8b66) from [::1]:44552
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (0a166555-8b66) from [::1]:44552
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stdout] test test_server_stats ... ok
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (0a166555-8b66) STAT 49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5 from [::1]:44552
[INFO] [stderr] INFO - udstunnel::tunnel::server 185 STATS (0a166555-8b66) from [::1]:44552
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:55954, peer: [::1]:42683, fd: 3 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (d30cdf12-dd9d) from [::1]:55954
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (d30cdf12-dd9d) from [::1]:55954
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (d30cdf12-dd9d) TEST from [::1]:55954
[INFO] [stderr] INFO - udstunnel::tunnel::server 175 TEST (d30cdf12-dd9d) from [::1]:55954
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stdout] test test_server_test_command ... ok
[INFO] [stderr] ERROR - udstunnel::tunnel::server 300 HANDSHAKE (3b150263-113b) error from [::1]:37588: timed out
[INFO] [stdout] test test_timedout_command ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.21s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_server_connectivity.rs (/opt/rustwide/target/debug/deps/test_server_connectivity-89d860c0b18d115d)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr] DEBUG - udstunnel::tunnel::config 264 Configuration loaded: Config { pidfile: "/tmp/udstunnel.pid", user: "dkmaster", loglevel: "DEBUG", logfile: Some("/tmp/tunnel.log"), logsize: 125829120, lognumber: 3, listen_address: "[::]", listen_port: 7777, ipv6: true, workers: 2, ssl_min_tls_version: "1.3", ssl_certificate: "tests/certs/cert.pem", ssl_certificate_key: "tests/certs/key.pem", ssl_ciphers: "TLS_AES_256_GCM_SHA384:TLS_CHACHA20_POLY1305_SHA256:ECDHE-ECDSA-CHACHA20-POLY1305-SHA256", uds_server: "http://127.0.0.1:8000/uds/rest/tunnel/ticket", uds_token: "uds_token", uds_timeout: 4s, uds_verify_ssl: false, handshake_timeout: 1s, command_timeout: 1s, secret: "49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5", allow: ["127.0.0.1", "127.0.0.2", "::1"] }
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::config 264 Configuration loaded: Config { pidfile: "/tmp/udstunnel.pid", user: "dkmaster", loglevel: "DEBUG", logfile: Some("/tmp/tunnel.log"), logsize: 125829120, lognumber: 3, listen_address: "[::]", listen_port: 7777, ipv6: true, workers: 2, ssl_min_tls_version: "1.3", ssl_certificate: "tests/certs/cert.pem", ssl_certificate_key: "tests/certs/key.pem", ssl_ciphers: "TLS_AES_256_GCM_SHA384:TLS_CHACHA20_POLY1305_SHA256:ECDHE-ECDSA-CHACHA20-POLY1305-SHA256", uds_server: "http://127.0.0.1:8000/uds/rest/tunnel/ticket", uds_token: "uds_token", uds_timeout: 4s, uds_verify_ssl: false, handshake_timeout: 1s, command_timeout: 1s, secret: "49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5", allow: ["127.0.0.1", "127.0.0.2", "::1"] }
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:33647
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:36527
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:46511
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (cc82475e-4a64) from [::1]:33774
[INFO] [stdout] test test_server_listens ... ok
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:46511
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (5b849b50-4587) from [::1]:60556
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:41812, peer: [::1]:46511, fd: 4 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (38c56f9d-11cb) from [::1]:41812
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (38c56f9d-11cb) from [::1]:41812
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[INFO] [stdout] test test_server_handshake ... ok
[INFO] [stderr] ERROR - udstunnel::tunnel::server 300 HANDSHAKE (5b849b50-4587) error from [::1]:60556: timed out
[INFO] [stdout] test test_server_handshake_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.42s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_server_to_remote.rs (/opt/rustwide/target/debug/deps/test_server_to_remote-f4558977e7ee3c7f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr] DEBUG - udstunnel::tls::crypto_provider 59 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 68 cipher_suites: [TLS13_AES_256_GCM_SHA384, TLS13_CHACHA20_POLY1305_SHA256, TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256]
[INFO] [stderr] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:45427
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:45427
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:33232, peer: [::1]:45427, fd: 11 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - rustls::client::hs 141 Not resuming any session
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 58 Supported verify schemes
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (d54e892c-714d) from [::1]:33232
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (d54e892c-714d) from [::1]:33232
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::client::tls13 423 TLS1.3 encrypted extensions: [ServerNameAck]
[INFO] [stderr] DEBUG - rustls::client::hs 662 ALPN protocol is None
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 22 Skipping server verification
[INFO] [stderr] DEBUG - udstunnel::tls::noverify 50 Skipping TLS 1.3 signature verification
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (d54e892c-714d) OPEN xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx from [::1]:33232
[INFO] [stderr] DEBUG - test_server_to_remote::fake::tunnel_server 49 Mocked request: ticket: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx msg: ::1 param:
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 78 UDS Response: UdsTicketResponse { host: "[::1]", port: 37523, notify: "notify_012345678901234567890123456789012" }
[INFO] [stderr] INFO - udstunnel::tunnel::relay 105 OPEN TUNNEL (d54e892c-714d) FROM [::1]:33232 to [::1]:37523
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 238 Waiting for any to complete
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 146 Starting server_to_client task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 196 Starting client_to_server task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 200 Stopping client_to_server task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 150 Stopping server_to_client task
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 244 Write task completed: Ok(())
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 258 Notifying end to UDS
[INFO] [stderr] INFO - udstunnel::tunnel::relay 265 TERMINATED (d54e892c-714d) [::1]:33232 to [::1]:37523, s:128, r:128, t:0
[INFO] [stderr] DEBUG - test_server_to_remote::fake::tunnel_server 49 Mocked request: ticket: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx msg: stop param:sent=128&recv=128&elapsed=0
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 260 End of tunnel relay
[INFO] [stdout] test test_server_to_remote ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests udstunnel
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/tunnel/config.rs - tunnel::config::Config (line 32) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.19s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "885b917676333255e9c750b1c116899562f6bee6cacc9abcd1d5e19498ad3bf3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "885b917676333255e9c750b1c116899562f6bee6cacc9abcd1d5e19498ad3bf3", kill_on_drop: false }`
[INFO] [stdout] 885b917676333255e9c750b1c116899562f6bee6cacc9abcd1d5e19498ad3bf3