[INFO] fetching crate turbomcp-auth 3.0.0-exp.2... [INFO] testing turbomcp-auth-3.0.0-exp.2 against master#7704328ba5ae8d6ce0ac303c9d5a1a1605906766 for pr-146989 [INFO] extracting crate turbomcp-auth 3.0.0-exp.2 into /workspace/builds/worker-1-tc1/source [INFO] started tweaking crates.io crate turbomcp-auth 3.0.0-exp.2 [INFO] removed 0 missing examples [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate turbomcp-auth 3.0.0-exp.2 [INFO] tweaked toml for crates.io crate turbomcp-auth 3.0.0-exp.2 written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate turbomcp-auth 3.0.0-exp.2 on toolchain 7704328ba5ae8d6ce0ac303c9d5a1a1605906766 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate turbomcp-auth 3.0.0-exp.2 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" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded wiremock v0.6.5 [INFO] [stderr] Downloaded rend v0.5.3 [INFO] [stderr] Downloaded bytecheck v0.8.2 [INFO] [stderr] Downloaded munge_macro v0.4.7 [INFO] [stderr] Downloaded ptr_meta v0.3.1 [INFO] [stderr] Downloaded zmij v1.0.4 [INFO] [stderr] Downloaded sonic-simd v0.1.2 [INFO] [stderr] Downloaded secrecy v0.8.0 [INFO] [stderr] Downloaded rancor v0.1.1 [INFO] [stderr] Downloaded bytecheck_derive v0.8.2 [INFO] [stderr] Downloaded ptr_meta_derive v0.3.1 [INFO] [stderr] Downloaded turbomcp-core v3.0.0-exp.2 [INFO] [stderr] Downloaded rusty-fork v0.3.1 [INFO] [stderr] Downloaded lexical-core v1.0.6 [INFO] [stderr] Downloaded halfbrown v0.2.5 [INFO] [stderr] Downloaded bon v3.8.1 [INFO] [stderr] Downloaded lexical-write-integer v1.0.6 [INFO] [stderr] Downloaded oauth2 v5.0.0 [INFO] [stderr] Downloaded lexical-write-float v1.0.6 [INFO] [stderr] Downloaded lexical-util v1.0.7 [INFO] [stderr] Downloaded bon-macros v3.8.1 [INFO] [stderr] Downloaded rkyv v0.8.13 [INFO] [stderr] Downloaded lexical-parse-float v1.0.6 [INFO] [stderr] Downloaded simd-json v0.13.11 [INFO] [stderr] Downloaded sonic-rs v0.3.17 [INFO] [stderr] Downloaded turbomcp-protocol v3.0.0-exp.2 [INFO] [stderr] Downloaded turbomcp-dpop v3.0.0-exp.2 [INFO] [stderr] Downloaded jsonwebtoken v10.2.0 [INFO] [stderr] Downloaded compact_str v0.7.1 [INFO] [stderr] Downloaded syn v2.0.112 [INFO] [stderr] Downloaded lexical-parse-integer v1.0.6 [INFO] [stderr] Downloaded sonic-number v0.1.0 [INFO] [stderr] Downloaded value-trait v0.8.1 [INFO] [stderr] Downloaded faststr v0.2.32 [INFO] [stderr] Downloaded munge v0.4.7 [INFO] [stderr] Downloaded rkyv_derive v0.8.13 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] aa936e7b84a1e703e8748d1085312fc68e5e910d19b19166d6d8694621f2d397 [INFO] running `Command { std: "docker" "start" "-a" "aa936e7b84a1e703e8748d1085312fc68e5e910d19b19166d6d8694621f2d397", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "aa936e7b84a1e703e8748d1085312fc68e5e910d19b19166d6d8694621f2d397", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "aa936e7b84a1e703e8748d1085312fc68e5e910d19b19166d6d8694621f2d397", kill_on_drop: false }` [INFO] [stdout] aa936e7b84a1e703e8748d1085312fc68e5e910d19b19166d6d8694621f2d397 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] af0b9142f83e67ace8b0bbcac8e968c84fb1d580aa3a391554dbefc72a9e2d11 [INFO] running `Command { std: "docker" "start" "-a" "af0b9142f83e67ace8b0bbcac8e968c84fb1d580aa3a391554dbefc72a9e2d11", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.104 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling find-msvc-tools v0.1.6 [INFO] [stderr] Compiling zerocopy v0.8.31 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling jobserver v0.1.34 [INFO] [stderr] Compiling getrandom v0.3.4 [INFO] [stderr] Compiling errno v0.3.14 [INFO] [stderr] Compiling socket2 v0.6.1 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling zmij v1.0.4 [INFO] [stderr] Compiling ahash v0.8.12 [INFO] [stderr] Compiling http v1.4.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.8 [INFO] [stderr] Compiling cc v1.2.51 [INFO] [stderr] Compiling serde_json v1.0.148 [INFO] [stderr] Compiling rustls-pki-types v1.13.2 [INFO] [stderr] Compiling lexical-util v1.0.7 [INFO] [stderr] Compiling dunce v1.0.5 [INFO] [stderr] Compiling rustls v0.23.35 [INFO] [stderr] Compiling fs_extra v1.3.0 [INFO] [stderr] Compiling ref-cast v1.0.25 [INFO] [stderr] Compiling castaway v0.2.4 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling crc32fast v1.5.0 [INFO] [stderr] Compiling time-core v0.1.6 [INFO] [stderr] Compiling simdutf8 v0.1.5 [INFO] [stderr] Compiling deranged v0.5.5 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling simd-adler32 v0.3.8 [INFO] [stderr] Compiling aws-lc-rs v1.15.2 [INFO] [stderr] Compiling time-macros v0.2.24 [INFO] [stderr] Compiling iri-string v0.7.10 [INFO] [stderr] Compiling webpki-roots v1.0.4 [INFO] [stderr] Compiling adler2 v2.0.1 [INFO] [stderr] Compiling regex-automata v0.4.13 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling quote v1.0.42 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling crossbeam-queue v0.3.12 [INFO] [stderr] Compiling crossbeam-channel v0.5.15 [INFO] [stderr] Compiling sonic-number v0.1.0 [INFO] [stderr] Compiling syn v2.0.112 [INFO] [stderr] Compiling cmake v0.1.57 [INFO] [stderr] Compiling lexical-parse-integer v1.0.6 [INFO] [stderr] Compiling lexical-write-integer v1.0.6 [INFO] [stderr] Compiling float-cmp v0.9.0 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling sonic-simd v0.1.2 [INFO] [stderr] Compiling bumpalo v3.19.1 [INFO] [stderr] Compiling lexical-write-float v1.0.6 [INFO] [stderr] Compiling lexical-parse-float v1.0.6 [INFO] [stderr] Compiling num-bigint v0.4.6 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling crossbeam v0.8.4 [INFO] [stderr] Compiling flate2 v1.1.5 [INFO] [stderr] Compiling pem v3.0.6 [INFO] [stderr] Compiling arc-swap v1.8.0 [INFO] [stderr] Compiling constant_time_eq v0.3.1 [INFO] [stderr] Compiling signature v2.2.0 [INFO] [stderr] Compiling urlencoding v2.1.3 [INFO] [stderr] Compiling lexical-core v1.0.6 [INFO] [stderr] Compiling time v0.3.44 [INFO] [stderr] Compiling uuid v1.19.0 [INFO] [stderr] Compiling serde_path_to_error v0.1.20 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling aws-lc-sys v0.35.0 [INFO] [stderr] Compiling blake3 v1.8.2 [INFO] [stderr] Compiling regex v1.12.2 [INFO] [stderr] Compiling rustls-webpki v0.103.8 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling zerocopy-derive v0.8.31 [INFO] [stderr] Compiling yoke-derive v0.8.1 [INFO] [stderr] Compiling zerovec-derive v0.11.2 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling tokio-macros v2.6.0 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling thiserror-impl v2.0.17 [INFO] [stderr] Compiling ref-cast-impl v1.0.25 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling async-trait v0.1.89 [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.1 [INFO] [stderr] Compiling thiserror v2.0.17 [INFO] [stderr] Compiling simple_asn1 v0.6.3 [INFO] [stderr] Compiling zerovec v0.11.5 [INFO] [stderr] Compiling zerotrie v0.2.3 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling tracing v0.1.44 [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 icu_provider v2.1.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling half v2.7.1 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling icu_properties v2.1.2 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling chrono v0.4.42 [INFO] [stderr] Compiling hashbrown v0.15.5 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling icu_normalizer v2.1.1 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling compact_str v0.8.1 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling faststr v0.2.32 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling sonic-rs v0.3.17 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling compact_str v0.7.1 [INFO] [stderr] Compiling secrecy v0.8.0 [INFO] [stderr] Compiling halfbrown v0.2.5 [INFO] [stderr] Compiling dashmap v6.1.0 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling value-trait v0.8.1 [INFO] [stderr] Compiling idna v1.1.0 [INFO] [stderr] Compiling turbomcp-core v3.0.0-exp.2 [INFO] [stderr] Compiling simd-json v0.13.11 [INFO] [stderr] Compiling url v2.5.7 [INFO] [stderr] Compiling hyper v1.8.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tokio-util v0.7.17 [INFO] [stderr] Compiling tower-http v0.6.8 [INFO] [stderr] Compiling hyper-util v0.1.19 [INFO] [stderr] Compiling turbomcp-protocol v3.0.0-exp.2 [INFO] [stderr] Compiling hyper-rustls v0.27.7 [INFO] [stderr] Compiling jsonwebtoken v10.2.0 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling oauth2 v5.0.0 [INFO] [stderr] Compiling turbomcp-auth v3.0.0-exp.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 58.12s [INFO] running `Command { std: "docker" "inspect" "af0b9142f83e67ace8b0bbcac8e968c84fb1d580aa3a391554dbefc72a9e2d11", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "af0b9142f83e67ace8b0bbcac8e968c84fb1d580aa3a391554dbefc72a9e2d11", kill_on_drop: false }` [INFO] [stdout] af0b9142f83e67ace8b0bbcac8e968c84fb1d580aa3a391554dbefc72a9e2d11 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0e90c0176cb62dcddec8fa45fc131e1adee6aa1ee2da1ee5f95063b482d93a2c [INFO] running `Command { std: "docker" "start" "-a" "0e90c0176cb62dcddec8fa45fc131e1adee6aa1ee2da1ee5f95063b482d93a2c", kill_on_drop: false }` [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling chrono v0.4.42 [INFO] [stderr] Compiling rustix v1.1.3 [INFO] [stderr] Compiling float-cmp v0.9.0 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling async-stream-impl v0.3.6 [INFO] [stderr] Compiling num_cpus v1.17.0 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling bit-vec v0.8.0 [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling rand_xorshift v0.4.0 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling unarray v0.1.4 [INFO] [stderr] Compiling value-trait v0.8.1 [INFO] [stderr] Compiling num-bigint v0.4.6 [INFO] [stderr] Compiling simd-json v0.13.11 [INFO] [stderr] Compiling bit-set v0.8.0 [INFO] [stderr] Compiling async-stream v0.3.6 [INFO] [stderr] Compiling simple_asn1 v0.6.3 [INFO] [stderr] Compiling jsonwebtoken v10.2.0 [INFO] [stderr] Compiling turbomcp-core v3.0.0-exp.2 [INFO] [stderr] Compiling tempfile v3.24.0 [INFO] [stderr] Compiling rusty-fork v0.3.1 [INFO] [stderr] Compiling proptest v1.9.0 [INFO] [stderr] Compiling tokio-util v0.7.17 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling deadpool v0.12.3 [INFO] [stderr] Compiling tokio-stream v0.1.17 [INFO] [stderr] Compiling tokio-test v0.4.4 [INFO] [stderr] Compiling tower-http v0.6.8 [INFO] [stderr] Compiling h2 v0.4.12 [INFO] [stderr] Compiling turbomcp-protocol v3.0.0-exp.2 [INFO] [stderr] Compiling hyper v1.8.1 [INFO] [stderr] Compiling hyper-util v0.1.19 [INFO] [stderr] Compiling hyper-rustls v0.27.7 [INFO] [stderr] Compiling wiremock v0.6.5 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling oauth2 v5.0.0 [INFO] [stderr] Compiling turbomcp-auth v3.0.0-exp.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 47.40s [INFO] running `Command { std: "docker" "inspect" "0e90c0176cb62dcddec8fa45fc131e1adee6aa1ee2da1ee5f95063b482d93a2c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0e90c0176cb62dcddec8fa45fc131e1adee6aa1ee2da1ee5f95063b482d93a2c", kill_on_drop: false }` [INFO] [stdout] 0e90c0176cb62dcddec8fa45fc131e1adee6aa1ee2da1ee5f95063b482d93a2c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] eae3f9bbdc467fc1d402734030d5acc89dc5f61cca7dfb4c7aeb7f92c5040aa2 [INFO] running `Command { std: "docker" "start" "-a" "eae3f9bbdc467fc1d402734030d5acc89dc5f61cca7dfb4c7aeb7f92c5040aa2", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.46s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/turbomcp_auth-536413d417814465) [INFO] [stdout] [INFO] [stdout] running 102 tests [INFO] [stdout] test api_key_validation::tests::test_blake3_hash_consistency ... ok [INFO] [stdout] test api_key_validation::tests::test_long_keys ... ok [INFO] [stdout] test api_key_validation::tests::test_special_characters ... ok [INFO] [stdout] test api_key_validation::tests::test_unicode_keys ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_case_sensitive ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_incorrect_key ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_multiple_keys_empty_list ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_correct_key ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_multiple_keys_first_match ... ok [INFO] [stdout] test api_key_validation::tests::test_blake3_hash_collision_resistance ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_short_keys_rejected ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_suffix_mismatch ... ok [INFO] [stdout] test audit::tests::test_audit_logger_creation ... ok [INFO] [stdout] test audit::tests::test_identifier_hashing ... ok [INFO] [stdout] test audit::tests::test_event_serialization ... ok [INFO] [stdout] test audit::tests::test_ip_redaction ... ok [INFO] [stdout] test context::tests::test_builder_minimal ... ok [INFO] [stdout] test context::tests::test_builder_full ... ok [INFO] [stdout] test context::tests::test_is_expired ... ok [INFO] [stdout] test context::tests::test_has_all_roles ... ok [INFO] [stdout] test context::tests::test_metadata ... ok [INFO] [stdout] test context::tests::test_validation_audience ... ok [INFO] [stdout] test context::tests::test_validation_not_yet_valid ... ok [INFO] [stdout] test introspection::tests::test_introspection_client_creation ... ok [INFO] [stdout] test introspection::tests::test_introspection_response_active ... ok [INFO] [stdout] test introspection::tests::test_introspection_response_full ... ok [INFO] [stdout] test introspection::tests::test_introspection_response_inactive ... ok [INFO] [stdout] test jwt::jwks::tests::test_cached_jwks_expired ... ok [INFO] [stdout] test jwt::jwks::tests::test_cached_jwks_validity ... ok [INFO] [stdout] test jwt::jwks::tests::test_clear_cache ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_prefix_mismatch ... ok [INFO] [stdout] test context::tests::test_has_any_role ... ok [INFO] [stdout] test context::tests::test_has_permission ... ok [INFO] [stdout] test jwt::jwks::tests::test_jwks_client_creation ... ok [INFO] [stdout] test context::tests::test_jwt_serialization ... ok [INFO] [stdout] test jwt::jwks::tests::test_jwks_client_with_custom_ttl ... ok [INFO] [stdout] test jwt::jwks::tests::test_jwks_cache_creation ... ok [INFO] [stdout] test jwt::validator::tests::test_jwt_validator_creation ... ok [INFO] [stdout] test context::tests::test_validation_expired ... ok [INFO] [stdout] test jwt::jwks::tests::test_jwks_cache_different_issuers ... ok [INFO] [stdout] test jwt::validator::tests::test_multi_issuer_validator_creation ... ok [INFO] [stdout] test jwt::validator::tests::test_multi_issuer_validator_add_issuer ... ok [INFO] [stdout] test jwt::validator::tests::test_jwt_validator_custom_algorithms ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_multiple_keys_middle_match ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_multiple_keys_no_match ... ok [INFO] [stdout] test context::tests::test_has_role ... ok [INFO] [stdout] test jwt::validator::tests::test_jwt_validator_custom_clock_skew ... ok [INFO] [stdout] test manager::tests::test_oauth2_config ... ok [INFO] [stdout] test oauth2::dcr::tests::test_dcr_builder_mcp_client ... ok [INFO] [stdout] test oauth2::dcr::tests::test_dcr_builder_native_client ... ok [INFO] [stdout] test oauth2::resource::tests::test_fragment_rejected ... ok [INFO] [stdout] test manager::tests::test_oauth2_pkce_integration ... ok [INFO] [stdout] test manager::tests::test_auth_manager ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_multiple_keys_last_match ... ok [INFO] [stdout] test manager::tests::test_api_key_provider ... ok [INFO] [stdout] test oauth2::dcr::tests::test_dcr_client_creation ... ok [INFO] [stdout] test oauth2::resource::tests::test_invalid_scheme_rejected ... ok [INFO] [stdout] test oauth2::resource::tests::test_http_non_localhost_rejected ... ok [INFO] [stdout] test oauth2::resource::tests::test_localhost_http_allowed ... ok [INFO] [stdout] test oauth2::resource::tests::test_mcp_examples ... ok [INFO] [stdout] test oauth2::resource::tests::test_missing_host_rejected ... ok [INFO] [stdout] test oauth2::dcr::tests::test_registration_response_deserialization ... ok [INFO] [stdout] test oauth2::resource::tests::test_port_handling ... ok [INFO] [stdout] test oauth2::resource::tests::test_valid_https_uri ... ok [INFO] [stdout] test oauth2::resource::tests::test_uri_normalization ... ok [INFO] [stdout] test oauth2::validation::tests::test_missing_host ... ok [INFO] [stdout] test oauth2::validation::tests::test_non_canonical_uppercase_scheme ... ok [INFO] [stdout] test oauth2::validation::tests::test_invalid_scheme ... ok [INFO] [stdout] test oauth2::validation::tests::test_valid_https_uri ... ok [INFO] [stdout] test oauth2::validation::tests::test_non_canonical_uppercase_host ... ok [INFO] [stdout] test oauth2::resource::tests::test_query_parameters_removed ... ok [INFO] [stdout] test rate_limit::tests::test_get_usage ... ok [INFO] [stdout] test providers::oauth2::tests::test_oauth2_provider_creation ... ok [INFO] [stdout] test oauth2::resource::tests::test_trailing_slash_removal ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limit_key_creation ... ok [INFO] [stdout] test oauth2::validation::tests::test_fragment_not_allowed ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_different_keys ... ok [INFO] [stdout] test oauth2::validation::tests::test_valid_http_uri ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_disabled ... ok [INFO] [stdout] test server::tests::test_audience_validation_case_insensitive ... ok [INFO] [stdout] test server::tests::test_audience_validation_exact_match ... ok [INFO] [stdout] test server::tests::test_audience_validation_path_significant ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_for_auth ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_blocks_over_limit ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_allows_under_limit ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_reset ... ok [INFO] [stdout] test rate_limit::tests::test_rate_limiter_allows_burst ... ok [INFO] [stdout] test server::tests::test_audience_validation_port_mismatch ... ok [INFO] [stdout] test server::tests::test_audience_validation_trailing_slash ... ok [INFO] [stdout] test server::tests::test_unauthorized_response ... ok [INFO] [stdout] test server::tests::test_www_authenticate_builder ... ok [INFO] [stdout] test server::tests::test_bearer_token_extraction_case_insensitive ... ok [INFO] [stdout] test server::tests::test_bearer_token_extraction_invalid_format ... ok [INFO] [stdout] test server::tests::test_metadata_builder ... ok [INFO] [stdout] test server::tests::test_normalize_resource_uri ... ok [INFO] [stdout] test server::tests::test_audience_validation_default_ports ... ok [INFO] [stdout] test server::tests::test_bearer_token_extraction ... ok [INFO] [stdout] test api_key_validation::tests::test_validate_empty_keys ... ok [INFO] [stdout] test audit::tests::test_audit_record_serialization ... ok [INFO] [stdout] test audit::tests::test_privacy_focused_logger ... ok [INFO] [stdout] test context::tests::test_has_scope ... ok [INFO] [stdout] test api_key_validation::tests::test_timing_attack_resistance ... FAILED [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- api_key_validation::tests::test_timing_attack_resistance stdout ---- [INFO] [stdout] Average timing difference: 2870ns per comparison [INFO] [stdout] [INFO] [stdout] thread 'api_key_validation::tests::test_timing_attack_resistance' (28) panicked at src/api_key_validation.rs:338:9: [INFO] [stdout] Timing difference too large: 2870ns (threshold: 500ns). This suggests potential timing attack vulnerability. [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5fe5ec147232 - std[ed5b486fa4cdb954]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5fe5ec147232 - std[ed5b486fa4cdb954]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5fe5ec147232 - std[ed5b486fa4cdb954]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5fe5ec147232 - <::print::DisplayBacktrace as core[ab67b43d93431064]::fmt::Display>::fmt [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5fe5ec15ef9a - ::fmt [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5fe5ec15ef9a - core[ab67b43d93431064]::fmt::write [INFO] [stdout] 6: 0x5fe5ec14c686 - std[ed5b486fa4cdb954]::io::default_write_fmt::> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5fe5ec14c686 - as std[ed5b486fa4cdb954]::io::Write>::write_fmt [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5fe5ec1243ef - ::print [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5fe5ec1243ef - std[ed5b486fa4cdb954]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5fe5ec13ed89 - std[ed5b486fa4cdb954]::panicking::default_hook [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5fe5ebc1260e - core[ab67b43d93431064]::ops::function::Fn<(&'a std[ed5b486fa4cdb954]::panic::PanicHookInfo<'b>,), Output = ()> + core[ab67b43d93431064]::marker::Send + core[ab67b43d93431064]::marker::Sync> as core[ab67b43d93431064]::ops::function::Fn<(&std[ed5b486fa4cdb954]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x5fe5ebc1260e - test[f0ec78552bebb08e]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5fe5ec13eff2 - core[ab67b43d93431064]::ops::function::Fn<(&'a std[ed5b486fa4cdb954]::panic::PanicHookInfo<'b>,), Output = ()> + core[ab67b43d93431064]::marker::Send + core[ab67b43d93431064]::marker::Sync> as core[ab67b43d93431064]::ops::function::Fn<(&std[ed5b486fa4cdb954]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x5fe5ec13eff2 - std[ed5b486fa4cdb954]::panicking::panic_with_hook [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5fe5ec1244a8 - std[ed5b486fa4cdb954]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5fe5ec11be29 - std[ed5b486fa4cdb954]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5fe5ec1254cd - __rustc[5067f77124470312]::rust_begin_unwind [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5fe5ec15f6dc - core[ab67b43d93431064]::panicking::panic_fmt [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5fe5ebbafdc6 - turbomcp_auth[8393e3d9eaaf7ca6]::api_key_validation::tests::test_timing_attack_resistance [INFO] [stdout] at /opt/rustwide/workdir/src/api_key_validation.rs:338:9 [INFO] [stdout] 20: 0x5fe5ebbae6c7 - turbomcp_auth[8393e3d9eaaf7ca6]::api_key_validation::tests::test_timing_attack_resistance::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/api_key_validation.rs:290:39 [INFO] [stdout] 21: 0x5fe5ebb8b1d6 - >::call_once [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5fe5ebc069bb - core[ab67b43d93431064]::result::Result<(), alloc[8787631d7fe8ec5a]::string::String> as core[ab67b43d93431064]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x5fe5ebc069bb - test[f0ec78552bebb08e]::__rust_begin_short_backtrace::, fn() -> core[ab67b43d93431064]::result::Result<(), alloc[8787631d7fe8ec5a]::string::String>> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:663:18 [INFO] [stdout] 24: 0x5fe5ebc1321a - test[f0ec78552bebb08e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:686:74 [INFO] [stdout] 25: 0x5fe5ebc1321a - as core[ab67b43d93431064]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 26: 0x5fe5ebc1321a - std[ed5b486fa4cdb954]::panicking::catch_unwind::do_call::, core[ab67b43d93431064]::result::Result<(), alloc[8787631d7fe8ec5a]::string::String>> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:581:40 [INFO] [stdout] 27: 0x5fe5ebc1321a - std[ed5b486fa4cdb954]::panicking::catch_unwind::, core[ab67b43d93431064]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:544:19 [INFO] [stdout] 28: 0x5fe5ebc1321a - std[ed5b486fa4cdb954]::panic::catch_unwind::, core[ab67b43d93431064]::result::Result<(), alloc[8787631d7fe8ec5a]::string::String>> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panic.rs:359:14 [INFO] [stdout] 29: 0x5fe5ebc1321a - test[f0ec78552bebb08e]::run_test_in_process [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:686:27 [INFO] [stdout] 30: 0x5fe5ebc1321a - test[f0ec78552bebb08e]::run_test::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:607:43 [INFO] [stdout] 31: 0x5fe5ebc0e7c4 - test[f0ec78552bebb08e]::run_test::{closure#1} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/test/src/lib.rs:637:41 [INFO] [stdout] 32: 0x5fe5ebc0e7c4 - std[ed5b486fa4cdb954]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 33: 0x5fe5ebc15d12 - std[ed5b486fa4cdb954]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 34: 0x5fe5ebc15d12 - ::{closure#1}::{closure#0}> as core[ab67b43d93431064]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 35: 0x5fe5ebc15d12 - std[ed5b486fa4cdb954]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:581:40 [INFO] [stdout] 36: 0x5fe5ebc15d12 - std[ed5b486fa4cdb954]::panicking::catch_unwind::<(), core[ab67b43d93431064]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panicking.rs:544:19 [INFO] [stdout] 37: 0x5fe5ebc15d12 - std[ed5b486fa4cdb954]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/panic.rs:359:14 [INFO] [stdout] 38: 0x5fe5ebc15d12 - std[ed5b486fa4cdb954]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 39: 0x5fe5ebc15d12 - ::{closure#1} as core[ab67b43d93431064]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x5fe5ec146a9f - + core[ab67b43d93431064]::marker::Send> as core[ab67b43d93431064]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 41: 0x5fe5ec146a9f - ::new::thread_start [INFO] [stdout] at /rustc/7704328ba5ae8d6ce0ac303c9d5a1a1605906766/library/std/src/sys/thread/unix.rs:127:17 [INFO] [stdout] 42: 0x71e3fd476aa4 - [INFO] [stdout] 43: 0x71e3fd503a64 - clone [INFO] [stdout] 44: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] api_key_validation::tests::test_timing_attack_resistance [INFO] [stdout] [INFO] [stdout] test result: FAILED. 101 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "eae3f9bbdc467fc1d402734030d5acc89dc5f61cca7dfb4c7aeb7f92c5040aa2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "eae3f9bbdc467fc1d402734030d5acc89dc5f61cca7dfb4c7aeb7f92c5040aa2", kill_on_drop: false }` [INFO] [stdout] eae3f9bbdc467fc1d402734030d5acc89dc5f61cca7dfb4c7aeb7f92c5040aa2