[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-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdkmstr%2Fudstunnel" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/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-4-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-4-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]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.95
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.95
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.95
[INFO] [stderr]   Downloaded uuid v1.11.0
[INFO] [stderr]   Downloaded mirai-annotations v1.12.0
[INFO] [stderr]   Downloaded openssl-macros v0.1.1
[INFO] [stderr]   Downloaded tinyvec_macros v0.1.1
[INFO] [stderr]   Downloaded tinyvec v1.8.0
[INFO] [stderr]   Downloaded system-configuration v0.6.1
[INFO] [stderr]   Downloaded rustc-hash v2.0.0
[INFO] [stderr]   Downloaded ppv-lite86 v0.2.20
[INFO] [stderr]   Downloaded byteorder v1.5.0
[INFO] [stderr]   Downloaded quinn-udp v0.5.7
[INFO] [stderr]   Downloaded clang-sys v1.8.1
[INFO] [stderr]   Downloaded openssl-sys v0.9.105
[INFO] [stderr]   Downloaded const-random v0.1.18
[INFO] [stderr]   Downloaded downcast v0.11.0
[INFO] [stderr]   Downloaded nom v7.1.3
[INFO] [stderr]   Downloaded const-random-macro v0.1.16
[INFO] [stderr]   Downloaded zerocopy v0.7.35
[INFO] [stderr]   Downloaded rand_chacha v0.3.1
[INFO] [stderr]   Downloaded json5 v0.4.1
[INFO] [stderr]   Downloaded vcpkg v0.2.15
[INFO] [stderr]   Downloaded clap_derive v4.5.18
[INFO] [stderr]   Downloaded clap v4.5.21
[INFO] [stderr]   Downloaded rand v0.8.5
[INFO] [stderr]   Downloaded indexmap v2.6.0
[INFO] [stderr]   Downloaded unicode-segmentation v1.12.0
[INFO] [stderr]   Downloaded pest v2.7.14
[INFO] [stderr]   Downloaded hashbrown v0.15.1
[INFO] [stderr]   Downloaded clap_builder v4.5.21
[INFO] [stderr]   Downloaded rustix v0.38.41
[INFO] [stderr]   Downloaded winnow v0.6.20
[INFO] [stderr]   Downloaded yaml-rust2 v0.8.1
[INFO] [stderr]   Downloaded h2 v0.4.6
[INFO] [stderr]   Downloaded hyper v1.5.0
[INFO] [stderr]   Downloaded rustls v0.23.18
[INFO] [stderr]   Downloaded toml_edit v0.22.22
[INFO] [stderr]   Downloaded hashbrown v0.14.5
[INFO] [stderr]   Downloaded tokio-util v0.7.12
[INFO] [stderr]   Downloaded openssl v0.10.70
[INFO] [stderr]   Downloaded toml v0.8.19
[INFO] [stderr]   Downloaded allocator-api2 v0.2.20
[INFO] [stderr]   Downloaded config v0.14.1
[INFO] [stderr]   Downloaded http v1.1.0
[INFO] [stderr]   Downloaded pest_meta v2.7.14
[INFO] [stderr]   Downloaded web-sys v0.3.72
[INFO] [stderr]   Downloaded pest_derive v2.7.14
[INFO] [stderr]   Downloaded ron v0.8.1
[INFO] [stderr]   Downloaded ahash v0.8.11
[INFO] [stderr]   Downloaded env_filter v0.1.2
[INFO] [stderr]   Downloaded mockall_derive v0.13.1
[INFO] [stderr]   Downloaded webpki-roots v0.26.6
[INFO] [stderr]   Downloaded tokio v1.41.1
[INFO] [stderr]   Downloaded convert_case v0.6.0
[INFO] [stderr]   Downloaded libc v0.2.164
[INFO] [stderr]   Downloaded ucd-trie v0.1.7
[INFO] [stderr]   Downloaded anstream v0.6.18
[INFO] [stderr]   Downloaded env_logger v0.11.5
[INFO] [stderr]   Downloaded predicates-core v1.0.8
[INFO] [stderr]   Downloaded hyper-rustls v0.27.3
[INFO] [stderr]   Downloaded hyper-tls v0.6.0
[INFO] [stderr]   Downloaded bindgen v0.69.5
[INFO] [stderr]   Downloaded syn v2.0.87
[INFO] [stderr]   Downloaded dlv-list v0.5.2
[INFO] [stderr]   Downloaded hashlink v0.8.4
[INFO] [stderr]   Downloaded anstyle-parse v0.2.6
[INFO] [stderr]   Downloaded anstyle-wincon v3.0.6
[INFO] [stderr]   Downloaded colorchoice v1.0.3
[INFO] [stderr]   Downloaded predicates v3.1.2
[INFO] [stderr]   Downloaded predicates-tree v1.0.11
[INFO] [stderr]   Downloaded mockall v0.13.1
[INFO] [stderr]   Downloaded atomic-waker v1.1.2
[INFO] [stderr]   Downloaded ipnet v2.10.1
[INFO] [stderr]   Downloaded mime v0.3.17
[INFO] [stderr]   Downloaded zerocopy-derive v0.7.35
[INFO] [stderr]   Downloaded quinn-proto v0.11.9
[INFO] [stderr]   Downloaded reqwest v0.12.9
[INFO] [stderr]   Downloaded aws-lc-rs v1.11.0
[INFO] [stderr]   Downloaded rand_core v0.6.4
[INFO] [stderr]   Downloaded clap_lex v0.7.3
[INFO] [stderr]   Downloaded strsim v0.11.1
[INFO] [stderr]   Downloaded pest_generator v2.7.14
[INFO] [stderr]   Downloaded pathdiff v0.2.2
[INFO] [stderr]   Downloaded tiny-keccak v2.0.2
[INFO] [stderr]   Downloaded ordered-multimap v0.7.3
[INFO] [stderr]   Downloaded rust-ini v0.20.0
[INFO] [stderr]   Downloaded serde_spanned v0.6.8
[INFO] [stderr]   Downloaded toml_datetime v0.6.8
[INFO] [stderr]   Downloaded arraydeque v0.5.1
[INFO] [stderr]   Downloaded anstyle-query v1.1.2
[INFO] [stderr]   Downloaded is_terminal_polyfill v1.70.1
[INFO] [stderr]   Downloaded ring v0.17.13
[INFO] [stderr]   Downloaded utf8parse v0.2.2
[INFO] [stderr]   Downloaded fragile v2.0.0
[INFO] [stderr]   Downloaded anstyle v1.0.10
[INFO] [stderr]   Downloaded termtree v0.4.1
[INFO] [stderr]   Downloaded equivalent v1.0.1
[INFO] [stderr]   Downloaded itertools v0.12.1
[INFO] [stderr]   Downloaded cc v1.2.16
[INFO] [stderr]   Downloaded mio v1.0.2
[INFO] [stderr]   Downloaded tracing-core v0.1.32
[INFO] [stderr]   Downloaded encoding_rs v0.8.35
[INFO] [stderr]   Downloaded tracing v0.1.40
[INFO] [stderr]   Downloaded quinn v0.11.6
[INFO] [stderr]   Downloaded url v2.5.3
[INFO] [stderr]   Downloaded minimal-lexical v0.2.1
[INFO] [stderr]   Downloaded serde v1.0.215
[INFO] [stderr]   Downloaded linux-raw-sys v0.4.14
[INFO] [stderr]   Downloaded socket2 v0.5.7
[INFO] [stderr]   Downloaded security-framework v2.11.1
[INFO] [stderr]   Downloaded typenum v1.17.0
[INFO] [stderr]   Downloaded prettyplease v0.2.25
[INFO] [stderr]   Downloaded bytes v1.8.0
[INFO] [stderr]   Downloaded serde_derive v1.0.215
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.95
[INFO] [stderr]   Downloaded rustls-pki-types v1.10.0
[INFO] [stderr]   Downloaded miniz_oxide v0.8.0
[INFO] [stderr]   Downloaded tokio-stream v0.1.16
[INFO] [stderr]   Downloaded js-sys v0.3.72
[INFO] [stderr]   Downloaded proc-macro2 v1.0.89
[INFO] [stderr]   Downloaded unicode-ident v1.0.13
[INFO] [stderr]   Downloaded thiserror v2.0.3
[INFO] [stderr]   Downloaded rustls-pemfile v2.2.0
[INFO] [stderr]   Downloaded tempfile v3.14.0
[INFO] [stderr]   Downloaded native-tls v0.2.12
[INFO] [stderr]   Downloaded litemap v0.7.3
[INFO] [stderr]   Downloaded yoke v0.7.4
[INFO] [stderr]   Downloaded generic-array v0.14.7
[INFO] [stderr]   Downloaded digest v0.10.7
[INFO] [stderr]   Downloaded fs_extra v1.3.0
[INFO] [stderr]   Downloaded jobserver v0.1.32
[INFO] [stderr]   Downloaded tokio-rustls v0.26.0
[INFO] [stderr]   Downloaded redox_syscall v0.5.7
[INFO] [stderr]   Downloaded sha2 v0.10.8
[INFO] [stderr]   Downloaded cexpr v0.6.0
[INFO] [stderr]   Downloaded tokio-test v0.4.4
[INFO] [stderr]   Downloaded thiserror-impl v2.0.3
[INFO] [stderr]   Downloaded itoa v1.0.11
[INFO] [stderr]   Downloaded system-configuration-sys v0.6.0
[INFO] [stderr]   Downloaded core-foundation v0.9.4
[INFO] [stderr]   Downloaded fastrand v2.2.0
[INFO] [stderr]   Downloaded wasm-bindgen-futures v0.4.45
[INFO] [stderr]   Downloaded cpufeatures v0.2.15
[INFO] [stderr]   Downloaded crypto-common v0.1.6
[INFO] [stderr]   Downloaded glob v0.3.1
[INFO] [stderr]   Downloaded libloading v0.8.5
[INFO] [stderr]   Downloaded wasm-bindgen-backend v0.2.95
[INFO] [stderr]   Downloaded pkg-config v0.3.31
[INFO] [stderr]   Downloaded security-framework-sys v2.12.1
[INFO] [stderr]   Downloaded tokio-native-tls v0.3.1
[INFO] [stderr]   Downloaded zerofrom-derive v0.1.4
[INFO] [stderr]   Downloaded windows-result v0.2.0
[INFO] [stderr]   Downloaded windows-strings v0.1.0
[INFO] [stderr]   Downloaded windows-registry v0.2.0
[INFO] [stderr]   Downloaded block-buffer v0.10.4
[INFO] [stderr]   Downloaded version_check v0.9.5
[INFO] [stderr]   Downloaded lazycell v1.3.0
[INFO] [stderr]   Downloaded rustc-hash v1.1.0
[INFO] [stderr]   Downloaded home v0.5.9
[INFO] [stderr]   Downloaded dunce v1.0.5
[INFO] [stderr]   Downloaded hermit-abi v0.3.9
[INFO] [stderr]   Downloaded which v4.4.2
[INFO] [stderr]   Downloaded cmake v0.1.51
[INFO] [stderr]   Downloaded paste v1.0.15
[INFO] [stderr]   Downloaded async-stream-impl v0.3.6
[INFO] [stderr]   Downloaded async-stream v0.3.6
[INFO] [stderr]   Downloaded cfg_aliases v0.2.1
[INFO] [stderr]   Downloaded sync_wrapper v1.0.1
[INFO] [stderr]   Downloaded yoke-derive v0.7.4
[INFO] [stderr]   Downloaded zerofrom v0.1.4
[INFO] [stderr]   Downloaded errno v0.3.9
[INFO] [stderr]   Downloaded aws-lc-sys v0.23.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e382e14a3d7b4a5ed8efa9a8956c5c5fc07acef9897cee9dfacdcd7d51b51b6a
[INFO] running `Command { std: "docker" "start" "-a" "e382e14a3d7b4a5ed8efa9a8956c5c5fc07acef9897cee9dfacdcd7d51b51b6a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e382e14a3d7b4a5ed8efa9a8956c5c5fc07acef9897cee9dfacdcd7d51b51b6a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e382e14a3d7b4a5ed8efa9a8956c5c5fc07acef9897cee9dfacdcd7d51b51b6a", kill_on_drop: false }`
[INFO] [stdout] e382e14a3d7b4a5ed8efa9a8956c5c5fc07acef9897cee9dfacdcd7d51b51b6a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-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] f63b21eb87849e96a999eee6dd0f5592f448cbd5a59eb259dad8531b8f919225
[INFO] running `Command { std: "docker" "start" "-a" "f63b21eb87849e96a999eee6dd0f5592f448cbd5a59eb259dad8531b8f919225", 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 once_cell v1.20.2
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling serde v1.0.215
[INFO] [stderr]    Compiling autocfg v1.4.0
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling bytes v1.8.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.15
[INFO] [stderr]    Compiling fs_extra v1.3.0
[INFO] [stderr]    Compiling dunce v1.0.5
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling pkg-config v0.3.31
[INFO] [stderr]    Compiling hashbrown v0.15.1
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling litemap v0.7.3
[INFO] [stderr]    Compiling lock_api v0.4.12
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling crunchy v0.2.2
[INFO] [stderr]    Compiling writeable v0.5.5
[INFO] [stderr]    Compiling http v1.1.0
[INFO] [stderr]    Compiling syn v2.0.87
[INFO] [stderr]    Compiling jobserver v0.1.32
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling mio v1.0.2
[INFO] [stderr]    Compiling cc v1.2.16
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling socket2 v0.5.7
[INFO] [stderr]    Compiling signal-hook-registry v1.4.2
[INFO] [stderr]    Compiling indexmap v2.6.0
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling ahash v0.8.11
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling aws-lc-rs v1.11.0
[INFO] [stderr]    Compiling tiny-keccak v2.0.2
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling httparse v1.9.5
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling icu_locid_transform_data v1.5.0
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling rustls-pki-types v1.10.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling cmake v0.1.51
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling untrusted v0.9.0
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling icu_properties_data v1.5.0
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling ucd-trie v0.1.7
[INFO] [stderr]    Compiling allocator-api2 v0.2.20
[INFO] [stderr]    Compiling mirai-annotations v1.12.0
[INFO] [stderr]    Compiling openssl v0.10.70
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling zeroize v1.8.1
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling const-random-macro v0.1.16
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling rustls v0.23.18
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling icu_normalizer_data v1.5.0
[INFO] [stderr]    Compiling native-tls v0.2.12
[INFO] [stderr]    Compiling utf16_iter v1.0.5
[INFO] [stderr]    Compiling write16 v1.0.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 const-random v0.1.18
[INFO] [stderr]    Compiling anstyle-parse v0.2.6
[INFO] [stderr]    Compiling openssl-probe v0.1.5
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling anstyle v1.0.10
[INFO] [stderr]    Compiling colorchoice v1.0.3
[INFO] [stderr]    Compiling anstyle-query v1.1.2
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling anstream v0.6.18
[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 ordered-multimap v0.7.3
[INFO] [stderr]    Compiling http-body-util v0.1.2
[INFO] [stderr]    Compiling hashlink v0.8.4
[INFO] [stderr]    Compiling webpki-roots v0.26.6
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling synstructure v0.13.1
[INFO] [stderr]    Compiling clap_lex v0.7.3
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling clap_builder v4.5.21
[INFO] [stderr]    Compiling yaml-rust2 v0.8.1
[INFO] [stderr]    Compiling convert_case v0.6.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling rust-ini v0.20.0
[INFO] [stderr]    Compiling rustls-pemfile v2.2.0
[INFO] [stderr]    Compiling sync_wrapper v1.0.1
[INFO] [stderr]    Compiling pathdiff v0.2.2
[INFO] [stderr]    Compiling ipnet v2.10.1
[INFO] [stderr]    Compiling cpufeatures v0.2.15
[INFO] [stderr]    Compiling sha2 v0.10.8
[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 zerofrom v0.1.4
[INFO] [stderr]    Compiling yoke v0.7.4
[INFO] [stderr]    Compiling icu_provider_macros v1.5.0
[INFO] [stderr]    Compiling zerovec v0.10.4
[INFO] [stderr]    Compiling tokio v1.41.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling tinystr v0.7.6
[INFO] [stderr]    Compiling icu_collections v1.5.0
[INFO] [stderr]    Compiling env_filter v0.1.2
[INFO] [stderr]    Compiling icu_locid v1.5.0
[INFO] [stderr]    Compiling async-trait v0.1.83
[INFO] [stderr]    Compiling pest v2.7.14
[INFO] [stderr]    Compiling icu_provider v1.5.0
[INFO] [stderr]    Compiling clap_derive v4.5.18
[INFO] [stderr]    Compiling icu_locid_transform v1.5.0
[INFO] [stderr]    Compiling env_logger v0.11.5
[INFO] [stderr]    Compiling uuid v1.11.0
[INFO] [stderr]    Compiling pest_meta v2.7.14
[INFO] [stderr]    Compiling icu_properties v1.5.1
[INFO] [stderr]    Compiling pest_generator v2.7.14
[INFO] [stderr]    Compiling clap v4.5.21
[INFO] [stderr]    Compiling pest_derive v2.7.14
[INFO] [stderr]    Compiling tokio-util v0.7.12
[INFO] [stderr]    Compiling bitflags v2.6.0
[INFO] [stderr]    Compiling icu_normalizer v1.5.0
[INFO] [stderr]    Compiling h2 v0.4.6
[INFO] [stderr]    Compiling serde_spanned v0.6.8
[INFO] [stderr]    Compiling toml_datetime v0.6.8
[INFO] [stderr]    Compiling idna_adapter v1.2.0
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling toml_edit v0.22.22
[INFO] [stderr]    Compiling url v2.5.3
[INFO] [stderr]    Compiling ron v0.8.1
[INFO] [stderr]    Compiling json5 v0.4.1
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling hyper v1.5.0
[INFO] [stderr]    Compiling toml v0.8.19
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling config v0.14.1
[INFO] [stderr]    Compiling hyper-util v0.1.10
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling rustls-webpki v0.102.8
[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 2m 47s
[INFO] running `Command { std: "docker" "inspect" "f63b21eb87849e96a999eee6dd0f5592f448cbd5a59eb259dad8531b8f919225", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f63b21eb87849e96a999eee6dd0f5592f448cbd5a59eb259dad8531b8f919225", kill_on_drop: false }`
[INFO] [stdout] f63b21eb87849e96a999eee6dd0f5592f448cbd5a59eb259dad8531b8f919225
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-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] 87c4a81efe689d713a81578a83f02b869aeb259079458b738dea46f096d1e581
[INFO] running `Command { std: "docker" "start" "-a" "87c4a81efe689d713a81578a83f02b869aeb259079458b738dea46f096d1e581", 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 tokio-test v0.4.4
[INFO] [stderr]    Compiling h2 v0.4.6
[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 48.15s
[INFO] running `Command { std: "docker" "inspect" "87c4a81efe689d713a81578a83f02b869aeb259079458b738dea46f096d1e581", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "87c4a81efe689d713a81578a83f02b869aeb259079458b738dea46f096d1e581", kill_on_drop: false }`
[INFO] [stdout] 87c4a81efe689d713a81578a83f02b869aeb259079458b738dea46f096d1e581
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-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] e87b20ea3459ae83cecc471a655f58a5eae037327858a5a359b14a12a1d82d10
[INFO] running `Command { std: "docker" "start" "-a" "e87b20ea3459ae83cecc471a655f58a5eae037327858a5a359b14a12a1d82d10", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.64s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/udstunnel-c1107b7628528a56)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tls::crypto_provider::test_valid_cipher_list ... ok
[INFO] [stdout] test tls::crypto_provider::test_invalid_cipher_list ... ok
[INFO] [stdout] test tls::crypto_provider::test_some_valid_cipher_list ... ok
[INFO] [stdout] test tunnel::types::tests::test_command_from_str ... ok
[INFO] [stdout] test tunnel::types::tests::test_response_to_string ... ok
[INFO] [stdout] test tls::crypto_provider::test_empty_cipher_list ... ok
[INFO] [stdout] test tunnel::event::test_event_wakes_all_wakers ... ok
[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.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/udstunnel-84f0ebb0af3bdf15)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_config.rs (/opt/rustwide/target/debug/deps/test_config-80505f815cbb913c)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tests::test_load_config_from_file ... ok
[INFO] [stdout] test tests::test_load_from_file_overrided_by_env ... ok
[INFO] [stdout] test tests::test_load_config_default ... ok
[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] [stderr]      Running tests/test_server_commands.rs (/opt/rustwide/target/debug/deps/test_server_commands-28271a5f055677b7)
[INFO] [stdout] 
[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] [stdout] running 5 tests
[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::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 [::]:46827
[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 [::]:39597
[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 [::]:45967
[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 [::]:39221
[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 [::]:45385
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:45385
[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:39597
[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:39221
[INFO] [stderr] DEBUG - udstunnel::tls::client 71 Loading certificates from: /etc/ssl/certs/ca-certificates.crt
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (7bbee9de-6f58) from [::1]:44146
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:45967
[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]:41362, peer: [::1]:39597, 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 (d383503f-4fbe) from [::1]:41362
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (d383503f-4fbe) from [::1]:41362
[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 (d383503f-4fbe) TEST from [::1]:41362
[INFO] [stderr] INFO - udstunnel::tunnel::server 175 TEST (d383503f-4fbe) from [::1]:41362
[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] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[INFO] [stderr] DEBUG - rustls::webpki::anchors 54 add_parsable_certificates processed 146 valid and 0 invalid certs
[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]:38442, peer: [::1]:45385, fd: 11 }) }
[INFO] [stderr] DEBUG - rustls::client::hs 83 No cached session for DnsName("localhost")
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:37574, peer: [::1]:39221, fd: 12 }) }
[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] 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 (3c16f644-643e) from [::1]:37574
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:60618, peer: [::1]:45967, fd: 13 }) }
[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 (f88f7a37-14f0) from [::1]:60618
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (141c39b9-31f9) from [::1]:38442
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (3c16f644-643e) from [::1]:37574
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (f88f7a37-14f0) from [::1]:60618
[INFO] [stderr] DEBUG - rustls::server::hs 441 decided upon suite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (141c39b9-31f9) from [::1]:38442
[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 (3c16f644-643e) UNKNOWN from [::1]:37574
[INFO] [stderr] ERROR - udstunnel::tunnel::server 306 COMMAND (3c16f644-643e) invalid from [::1]:37574: 5a4d4742a50100
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[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::client::hs 851 Using ciphersuite TLS13_AES_256_GCM_SHA384
[INFO] [stderr] DEBUG - rustls::client::tls13 141 Not resuming
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[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 (f88f7a37-14f0) STAT 49562cfc3b17139ea01c480b9c86a2ddacb38ff1b2e9db1bf66bab7a4e3f1fb5 from [::1]:60618
[INFO] [stderr] INFO - udstunnel::tunnel::server 264 COMMAND (141c39b9-31f9) OPEN xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx from [::1]:38442
[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: 34729, notify: "notify_012345678901234567890123456789012" }
[INFO] [stderr] INFO - udstunnel::tunnel::relay 105 OPEN TUNNEL (141c39b9-31f9) FROM [::1]:38442 to [::1]:34729
[INFO] [stderr] INFO - udstunnel::tunnel::server 185 STATS (f88f7a37-14f0) from [::1]:60618
[INFO] [stdout] test test_invalid_command ... ok
[INFO] [stderr] DEBUG - udstunnel::tunnel::relay 238 Waiting for any to complete
[INFO] [stderr] DEBUG - rustls::common_state 574 Sending warning alert CloseNotify
[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 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 (141c39b9-31f9) [::1]:38442 to [::1]:34729, 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] [stdout] test test_server_open_command ... ok
[INFO] [stdout] test test_server_stats ... ok
[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] ERROR - udstunnel::tunnel::server 300 HANDSHAKE (7bbee9de-6f58) error from [::1]:44146: timed out
[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::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::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] INFO - udstunnel::tunnel::server 87 Tunnel server running on [::]:36701
[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 [::]:43235
[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 [::]:41397
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (7d91d99c-f8f9) from [::1]:59096
[INFO] [stderr] INFO - udstunnel::tunnel::server 116 CONNECTION (e4acbf8a-bc69) from [::1]:51586
[INFO] [stdout] test test_server_listens ... ok
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:43235
[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] [stdout] test test_server_handshake ... ok
[INFO] [stderr] DEBUG - udstunnel::tunnel::client 24 Hook for connection established: PollEvented { io: Some(TcpStream { addr: [::1]:52374, peer: [::1]:43235, fd: 14 }) }
[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 (ab86243a-07c6) from [::1]:52374
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (ab86243a-07c6) from [::1]:52374
[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] [stderr] ERROR - udstunnel::tunnel::server 300 HANDSHAKE (7d91d99c-f8f9) error from [::1]:59096: timed out
[INFO] [stderr]      Running tests/test_server_to_remote.rs (/opt/rustwide/target/debug/deps/test_server_to_remote-f4558977e7ee3c7f)
[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.41s
[INFO] [stdout] 
[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 [::]:45795
[INFO] [stderr] DEBUG - udstunnel::tls::client 66 Connecting to localhost:45795
[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]:48138, peer: [::1]:45795, 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 (35d5d066-3276) from [::1]:48138
[INFO] [stderr] DEBUG - udstunnel::tunnel::server 146 HANDSHAKE (35d5d066-3276) from [::1]:48138
[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 (35d5d066-3276) OPEN xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx from [::1]:48138
[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: 40091, notify: "notify_012345678901234567890123456789012" }
[INFO] [stderr] INFO - udstunnel::tunnel::relay 105 OPEN TUNNEL (35d5d066-3276) FROM [::1]:48138 to [::1]:40091
[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 (35d5d066-3276) [::1]:48138 to [::1]:40091, 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.26s
[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.49s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e87b20ea3459ae83cecc471a655f58a5eae037327858a5a359b14a12a1d82d10", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e87b20ea3459ae83cecc471a655f58a5eae037327858a5a359b14a12a1d82d10", kill_on_drop: false }`
[INFO] [stdout] e87b20ea3459ae83cecc471a655f58a5eae037327858a5a359b14a12a1d82d10