[INFO] cloning repository https://github.com/unrelated-ai/mcp-gateway
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/unrelated-ai/mcp-gateway" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Funrelated-ai%2Fmcp-gateway", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Funrelated-ai%2Fmcp-gateway'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0b23c21775d91652c4a87eeceab9826545a3cd74
[INFO] testing unrelated-ai/mcp-gateway against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Funrelated-ai%2Fmcp-gateway" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-3-tc2/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/unrelated-ai/mcp-gateway
[INFO] finished tweaking git repo https://github.com/unrelated-ai/mcp-gateway
[INFO] tweaked toml for git repo https://github.com/unrelated-ai/mcp-gateway written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/unrelated-ai/mcp-gateway on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/unrelated-ai/mcp-gateway 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 54485df287b5ce64e591127943d1757d1e920bd33f6851347c30245408676133
[INFO] running `Command { std: "docker" "start" "-a" "54485df287b5ce64e591127943d1757d1e920bd33f6851347c30245408676133", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "54485df287b5ce64e591127943d1757d1e920bd33f6851347c30245408676133", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "54485df287b5ce64e591127943d1757d1e920bd33f6851347c30245408676133", kill_on_drop: false }`
[INFO] [stdout] 54485df287b5ce64e591127943d1757d1e920bd33f6851347c30245408676133
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9bd53cc5d08c2604f680ae0adfa8c3091d2421140d1f5e69e15af8b095d79495
[INFO] running `Command { std: "docker" "start" "-a" "9bd53cc5d08c2604f680ae0adfa8c3091d2421140d1f5e69e15af8b095d79495", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling find-msvc-tools v0.1.5
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling icu_properties_data v2.1.1
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling cc v1.2.48
[INFO] [stderr]    Compiling rustls-pki-types v1.13.1
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling ipnet v2.11.0
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling rand_core v0.10.0
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling signal-hook-registry v1.4.7
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling socket2 v0.6.1
[INFO] [stderr]    Compiling mio v1.1.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling chacha20 v0.10.0
[INFO] [stderr]    Compiling webpki-roots v1.0.4
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling rustls-webpki v0.103.10
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.1
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling url v2.5.7
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tokio-util v0.7.17
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling rmcp v1.2.0
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling iri-string v0.7.9
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling process-wrap v9.0.0
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling hyper-util v0.1.18
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling sse-stream v0.2.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling rmcp-macros v1.2.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling uuid v1.19.0
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling rand v0.10.0
[INFO] [stderr]    Compiling pastey v0.2.1
[INFO] [stderr]    Compiling unrelated-env v0.1.0 (/opt/rustwide/workdir/crates/env)
[INFO] [stderr]    Compiling openapiv3 v2.2.0
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling reqwest v0.12.24
[INFO] [stderr]    Compiling clap_builder v4.5.53
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling axum-core v0.5.5
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling axum-macros v0.5.0
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling matchit v0.8.4
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling clap v4.5.53
[INFO] [stderr]    Compiling unrelated-tool-transforms v0.1.0 (/opt/rustwide/workdir/crates/tool-transforms)
[INFO] [stderr]    Compiling axum v0.8.7
[INFO] [stderr]    Compiling unrelated-http-tools v0.1.0 (/opt/rustwide/workdir/crates/http-tools)
[INFO] [stderr]    Compiling unrelated-openapi-tools v0.1.0 (/opt/rustwide/workdir/crates/openapi-tools)
[INFO] [stderr]    Compiling unrelated-mcp-adapter v0.12.1 (/opt/rustwide/workdir/crates/adapter)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3m 29s
[INFO] running `Command { std: "docker" "inspect" "9bd53cc5d08c2604f680ae0adfa8c3091d2421140d1f5e69e15af8b095d79495", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9bd53cc5d08c2604f680ae0adfa8c3091d2421140d1f5e69e15af8b095d79495", kill_on_drop: false }`
[INFO] [stdout] 9bd53cc5d08c2604f680ae0adfa8c3091d2421140d1f5e69e15af8b095d79495
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 95a47c7159da1b7c2d3a969fc5a2fe9216823c36182fa67d3719e77e0ac915da
[INFO] running `Command { std: "docker" "start" "-a" "95a47c7159da1b7c2d3a969fc5a2fe9216823c36182fa67d3719e77e0ac915da", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling zerocopy v0.8.31
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling uuid v1.19.0
[INFO] [stderr]    Compiling prost-derive v0.14.3
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling darling_core v0.21.3
[INFO] [stderr]    Compiling ureq-proto v0.5.3
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling prost v0.14.3
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling process-wrap v9.0.0
[INFO] [stderr]    Compiling sse-stream v0.2.1
[INFO] [stderr]    Compiling bollard-buildkit-proto v0.7.0
[INFO] [stderr]    Compiling portable-atomic v1.13.0
[INFO] [stderr]    Compiling rmcp v1.2.0
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling ureq v3.1.4
[INFO] [stderr]    Compiling deranged v0.5.5
[INFO] [stderr]    Compiling darling_macro v0.21.3
[INFO] [stderr]    Compiling hyper-util v0.1.18
[INFO] [stderr]    Compiling prost-types v0.14.3
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling structmeta-derive v0.3.0
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling axum v0.8.7
[INFO] [stderr]    Compiling reqwest v0.12.24
[INFO] [stderr]    Compiling hyper-timeout v0.5.2
[INFO] [stderr]    Compiling structmeta v0.3.0
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling darling v0.21.3
[INFO] [stderr]    Compiling num-iter v0.1.45
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling serde_repr v0.1.20
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling openssl-probe v0.1.6
[INFO] [stderr]    Compiling num v0.4.3
[INFO] [stderr]    Compiling rustls-native-certs v0.8.2
[INFO] [stderr]    Compiling serde_with_macros v3.16.1
[INFO] [stderr]    Compiling hyperlocal v0.9.1
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling xattr v1.6.1
[INFO] [stderr]    Compiling filetime v0.2.26
[INFO] [stderr]    Compiling home v0.5.11
[INFO] [stderr]    Compiling parse-display-derive v0.9.1
[INFO] [stderr]    Compiling docker_credential v1.3.2
[INFO] [stderr]    Compiling astral-tokio-tar v0.5.6
[INFO] [stderr]    Compiling serde_with v3.16.1
[INFO] [stderr]    Compiling ferroid v0.8.9
[INFO] [stderr]    Compiling etcetera v0.11.0
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling unrelated-test-support v0.1.0 (/opt/rustwide/workdir/crates/test-support)
[INFO] [stderr]    Compiling parse-display v0.9.1
[INFO] [stderr]    Compiling tonic v0.14.2
[INFO] [stderr]    Compiling unrelated-http-tools v0.1.0 (/opt/rustwide/workdir/crates/http-tools)
[INFO] [stderr]    Compiling unrelated-openapi-tools v0.1.0 (/opt/rustwide/workdir/crates/openapi-tools)
[INFO] [stderr]    Compiling tonic-prost v0.14.2
[INFO] [stderr]    Compiling unrelated-mcp-adapter v0.12.1 (/opt/rustwide/workdir/crates/adapter)
[INFO] [stderr]    Compiling bollard-stubs v1.52.1-rc.29.1.3
[INFO] [stderr]    Compiling bollard v0.20.1
[INFO] [stderr]    Compiling testcontainers v0.27.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4m 13s
[INFO] running `Command { std: "docker" "inspect" "95a47c7159da1b7c2d3a969fc5a2fe9216823c36182fa67d3719e77e0ac915da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "95a47c7159da1b7c2d3a969fc5a2fe9216823c36182fa67d3719e77e0ac915da", kill_on_drop: false }`
[INFO] [stdout] 95a47c7159da1b7c2d3a969fc5a2fe9216823c36182fa67d3719e77e0ac915da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3cdaa4604bb3b8e472271f44995f79c3d82f3c6dc325e8714e8e36e33a7372e4
[INFO] running `Command { std: "docker" "start" "-a" "3cdaa4604bb3b8e472271f44995f79c3d82f3c6dc325e8714e8e36e33a7372e4", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.60s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/unrelated_mcp_adapter-f65ee5a2058025aa)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test aggregator::tests::server_prefixed_parses_last_colon ... ok
[INFO] [stdout] test aggregator::tests::test_route_tool ... ok
[INFO] [stdout] test aggregator::tests::server_prefixed_rejects_empty_parts ... ok
[INFO] [stdout] test aggregator::tests::tool_rename_changes_exposed_name_and_routes_to_original ... ok
[INFO] [stdout] test aggregator::tests::tool_rename_participates_in_collision_detection ... ok
[INFO] [stdout] test aggregator::tests::server_prefixed_roundtrip ... ok
[INFO] [stdout] test config::tests::effective_redacted_masks_sensitive_values ... ok
[INFO] [stdout] test config::tests::test_auto_discover_config_detailed ... ok
[INFO] [stdout] test config::tests::test_auto_discover_config_disabled ... ok
[INFO] [stdout] test config::tests::test_auto_discover_config_default ... ok
[INFO] [stdout] test aggregator::tests::test_collision_prefixing ... ok
[INFO] [stdout] test aggregator::tests::test_no_collision ... ok
[INFO] [stdout] test config::tests::legacy_imports_are_rejected_with_migration_message ... ok
[INFO] [stdout] test config::tests::empty_imports_list_is_allowed ... ok
[INFO] [stdout] test config::tests::test_expand_env_missing_var ... ok
[INFO] [stdout] test config::tests::test_expand_env_string ... ok
[INFO] [stderr]      Running unittests src/bin/stdio_list_changed_test_server.rs (/opt/rustwide/target/debug/deps/unrelated_mcp_stdio_list_changed_test_server-c1088bb224debc6c)
[INFO] [stdout] test mcp_server::tests::timeout_budget_from_meta_parses_and_clamps ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[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 unittests src/bin/stdio_test_server.rs (/opt/rustwide/target/debug/deps/unrelated_mcp_stdio_test_server-e36186be7e882754)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_http_tools.rs (/opt/rustwide/target/debug/deps/integration_http_tools-5b997c285253bc98)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test http_tools_echo_request_roundtrip ... ignored, requires Docker (testcontainers)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_map.rs (/opt/rustwide/target/debug/deps/integration_map-33c5d94e18e51190)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.117890Z","level":"INFO","fields":{"message":"Starting Unrelated MCP Adapter v0.12.1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.119336Z","level":"INFO","fields":{"message":"Loaded 2 server(s) from config"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.122820Z","level":"INFO","fields":{"message":"Creating HTTP backend: s1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.123307Z","level":"INFO","fields":{"message":"Creating HTTP backend: s2"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.123509Z","level":"INFO","fields":{"message":"Starting all backends..."},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.136902Z","level":"INFO","fields":{"message":"All backends started successfully"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.146867Z","level":"INFO","fields":{"message":"Starting HTTP server (MCP + aux) on 127.0.0.1:38207"},"target":"unrelated_mcp_adapter"}
[INFO] [stderr]      Running tests/integration_mixed.rs (/opt/rustwide/target/debug/deps/integration_mixed-9429d1a790c84a0c)
[INFO] [stdout] test map_exposes_prefixed_tools_on_collision ... ok
[INFO] [stderr]      Running tests/integration_openapi.rs (/opt/rustwide/target/debug/deps/integration_openapi-9c05ccc3cb8f8730)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test mixed_sources_tool_collision_is_prefixed_and_routed ... ignored, requires Docker (testcontainers)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/integration_stdio_lifecycle.rs (/opt/rustwide/target/debug/deps/integration_stdio_lifecycle-55f7f906bddc3a8a)
[INFO] [stdout] test openapi_roundtrip_add_pet_and_get_pet ... ignored, requires Docker (testcontainers)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.307048Z","level":"INFO","fields":{"message":"Starting Unrelated MCP Adapter v0.12.1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.307153Z","level":"INFO","fields":{"message":"Loaded 1 server(s) from config"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.307305Z","level":"INFO","fields":{"message":"Creating stdio backend: s1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.307355Z","level":"INFO","fields":{"message":"Starting all backends..."},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.307409Z","level":"INFO","fields":{"message":"Starting MCP server: s1"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.310290Z","level":"INFO","fields":{"message":"Starting Unrelated MCP Adapter v0.12.1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.310361Z","level":"INFO","fields":{"message":"Loaded 1 server(s) from config"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.310487Z","level":"INFO","fields":{"message":"Creating stdio backend: s1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.311948Z","level":"INFO","fields":{"message":"Starting Unrelated MCP Adapter v0.12.1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.312015Z","level":"INFO","fields":{"message":"Loaded 1 server(s) from config"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.312131Z","level":"INFO","fields":{"message":"Creating stdio backend: s1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.312171Z","level":"INFO","fields":{"message":"Starting all backends..."},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.312222Z","level":"INFO","fields":{"message":"Starting MCP server: s1"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.310530Z","level":"INFO","fields":{"message":"Starting all backends..."},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.312625Z","level":"INFO","fields":{"message":"Starting MCP server: s1"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.316781Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2025-06-18\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.317230Z","level":"INFO","fields":{"message":"MCP server 's1' connected: name=adapter-stdio-test-server, version=0"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.316891Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2025-06-18\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.317483Z","level":"INFO","fields":{"message":"MCP server 's1' connected: name=adapter-stdio-test-server, version=0"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.319376Z","level":"INFO","fields":{"message":"Discovered 1 tools, 0 resources, 0 prompts from MCP server 's1'"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.319502Z","level":"INFO","fields":{"message":"task cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.319967Z","level":"INFO","fields":{"message":"Child exited gracefully exit status: 0"},"target":"rmcp::transport::child_process","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.320032Z","level":"INFO","fields":{"message":"serve finished","quit_reason":"Cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.320197Z","level":"INFO","fields":{"message":"All backends started successfully"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.320700Z","level":"INFO","fields":{"message":"Starting HTTP server (MCP + aux) on 127.0.0.1:37965"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.336069Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2025-06-18\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.336265Z","level":"INFO","fields":{"message":"MCP server 's1' connected: name=adapter-stdio-test-server, version=0"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.337884Z","level":"INFO","fields":{"message":"Discovered 1 tools, 0 resources, 0 prompts from MCP server 's1'"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.337981Z","level":"INFO","fields":{"message":"task cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.338473Z","level":"INFO","fields":{"message":"Child exited gracefully exit status: 0"},"target":"rmcp::transport::child_process","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.338534Z","level":"INFO","fields":{"message":"serve finished","quit_reason":"Cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.338761Z","level":"INFO","fields":{"message":"All backends started successfully"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.339264Z","level":"INFO","fields":{"message":"Starting HTTP server (MCP + aux) on 127.0.0.1:40949"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.358314Z","level":"INFO","fields":{"message":"Discovered 1 tools, 0 resources, 0 prompts from MCP server 's1'"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.358396Z","level":"INFO","fields":{"message":"All backends started successfully"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.358919Z","level":"INFO","fields":{"message":"Starting HTTP server (MCP + aux) on 127.0.0.1:43379"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.523420Z","level":"INFO","fields":{"message":"create new session","session_id":"\"19279501-5f9b-42ce-b726-b3d1f4e9aa56\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.523639Z","level":"INFO","fields":{"message":"create new session","session_id":"\"00ea30ff-6e59-49bd-9b06-902ab2ac4068\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.524171Z","level":"INFO","fields":{"message":"create new session","session_id":"\"d0e227c0-2787-4178-9952-e6a0a9d834e7\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.526382Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.526469Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.527204Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.527323Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.527304Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.527422Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.528801Z","level":"INFO","fields":{"message":"create new session","session_id":"\"5d073cf9-e7d3-43da-9725-5604e1eefdc6\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.529832Z","level":"INFO","fields":{"message":"create new session","session_id":"\"bbd3b5d9-7dfd-409d-8172-da3f0ce9aefe\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.531116Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.531495Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532127Z","level":"INFO","fields":{"message":"task cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532224Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532310Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532313Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532603Z","level":"INFO","fields":{"message":"Child exited gracefully exit status: 0"},"target":"rmcp::transport::child_process","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.532669Z","level":"INFO","fields":{"message":"serve finished","quit_reason":"Cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.533707Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.573082Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.573846Z","level":"INFO","fields":{"message":"task cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.574700Z","level":"INFO","fields":{"message":"Child exited gracefully exit status: 0"},"target":"rmcp::transport::child_process","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.574768Z","level":"INFO","fields":{"message":"serve finished","quit_reason":"Cancelled"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] test stdio_lifecycle_per_call_spawns_new_process_for_each_call ... ok
[INFO] [stdout] test stdio_lifecycle_persistent_reuses_process_across_sessions ... ok
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.578483Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"},{"name":"serve_inner"}]}
[INFO] [stdout] test stdio_lifecycle_per_session_reuses_within_session_but_not_across_sessions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.29s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_stdio_list_changed_refresh.rs (/opt/rustwide/target/debug/deps/integration_stdio_list_changed_refresh-58c4cf75978bff06)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.607954Z","level":"INFO","fields":{"message":"Starting Unrelated MCP Adapter v0.12.1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.608053Z","level":"INFO","fields":{"message":"Loaded 1 server(s) from config"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.608226Z","level":"INFO","fields":{"message":"Creating stdio backend: s1"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.608277Z","level":"INFO","fields":{"message":"Starting all backends..."},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.608324Z","level":"INFO","fields":{"message":"Starting MCP server: s1"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.612972Z","level":"INFO","fields":{"message":"Service initialized as client","peer_info":"Some(InitializeResult { protocol_version: ProtocolVersion(\"2025-06-18\"), capabilities: ServerCapabilities { experimental: None, extensions: None, logging: None, completions: None, prompts: None, resources: None, tools: Some(ToolsCapability { list_changed: None }), tasks: None }, server_info: Implementation { name: \"adapter-stdio-list-changed-test-server\", title: None, version: \"0\", description: None, icons: None, website_url: None }, instructions: None })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.613179Z","level":"INFO","fields":{"message":"MCP server 's1' connected: name=adapter-stdio-list-changed-test-server, version=0"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.615138Z","level":"INFO","fields":{"message":"Discovered 2 tools, 0 resources, 0 prompts from MCP server 's1'"},"target":"unrelated_mcp_adapter::supervisor"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.615203Z","level":"INFO","fields":{"message":"All backends started successfully"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.615818Z","level":"INFO","fields":{"message":"Starting HTTP server (MCP + aux) on 127.0.0.1:39147"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.661714Z","level":"INFO","fields":{"message":"create new session","session_id":"\"37b91238-109a-4bde-a0b1-68ca69104eff\""},"target":"rmcp::transport::streamable_http_server::session::local"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.668654Z","level":"INFO","fields":{"message":"client initialized"},"target":"rmcp::handler::server"}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.670674Z","level":"INFO","fields":{"message":"Service initialized as server","peer_info":"Some(InitializeRequestParams { meta: None, protocol_version: ProtocolVersion(\"2024-11-05\"), capabilities: ClientCapabilities { experimental: None, extensions: None, roots: None, sampling: None, elicitation: None, tasks: None }, client_info: Implementation { name: \"unrelated-mcp-adapter-integration-tests\", title: None, version: \"0\", description: None, icons: None, website_url: None } })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.723641Z","level":"INFO","fields":{"message":"received notification","notification":"ToolListChangedNotification(NotificationNoParam { method: ToolListChangedNotificationMethod, extensions: Extensions })"},"target":"rmcp::service","span":{"name":"serve_inner"},"spans":[{"name":"serve_inner"}]}
[INFO] [stdout] {"timestamp":"2026-03-31T18:55:51.724110Z","level":"INFO","fields":{"message":"Registry refresh requested ([\"s1\"]); refreshing aggregated registry"},"target":"unrelated_mcp_adapter"}
[INFO] [stdout] test stdio_persistent_refreshes_registry_on_upstream_tools_list_changed ... ok
[INFO] [stderr]      Running tests/integration_streamable_http.rs (/opt/rustwide/target/debug/deps/integration_streamable_http-4058090428608377)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test streamable_http_tools_echo_request_roundtrip ... ignored, requires Docker (testcontainers)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3cdaa4604bb3b8e472271f44995f79c3d82f3c6dc325e8714e8e36e33a7372e4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3cdaa4604bb3b8e472271f44995f79c3d82f3c6dc325e8714e8e36e33a7372e4", kill_on_drop: false }`
[INFO] [stdout] 3cdaa4604bb3b8e472271f44995f79c3d82f3c6dc325e8714e8e36e33a7372e4