[INFO] fetching crate pulseengine-mcp-security-middleware 0.10.0...
[INFO] testing pulseengine-mcp-security-middleware-0.10.0 against master#ad85bc524b1ad696e42061ad8338d382dffbdbe5 for pr-146237
[INFO] extracting crate pulseengine-mcp-security-middleware 0.10.0 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate pulseengine-mcp-security-middleware 0.10.0
[INFO] finished tweaking crates.io crate pulseengine-mcp-security-middleware 0.10.0
[INFO] tweaked toml for crates.io crate pulseengine-mcp-security-middleware 0.10.0 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate pulseengine-mcp-security-middleware 0.10.0 on toolchain ad85bc524b1ad696e42061ad8338d382dffbdbe5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate pulseengine-mcp-security-middleware 0.10.0 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" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded validator_derive v0.20.0
[INFO] [stderr]   Downloaded num-cmp v0.1.0
[INFO] [stderr]   Downloaded iso8601 v0.6.3
[INFO] [stderr]   Downloaded validator v0.20.0
[INFO] [stderr]   Downloaded pulseengine-mcp-protocol v0.10.0
[INFO] [stderr]   Downloaded jsonwebtoken v9.3.1
[INFO] [stderr]   Downloaded fraction v0.15.3
[INFO] [stderr]   Downloaded keyring v3.6.2
[INFO] [stderr]   Downloaded jsonschema v0.18.3
[INFO] [stderr]   Downloaded nom v8.0.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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 30d7256c8bc6c1ea3b23deb936585aa0859477862fb7a027b78f7a9c85dead66
[INFO] running `Command { std: "docker" "start" "-a" "30d7256c8bc6c1ea3b23deb936585aa0859477862fb7a027b78f7a9c85dead66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "30d7256c8bc6c1ea3b23deb936585aa0859477862fb7a027b78f7a9c85dead66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "30d7256c8bc6c1ea3b23deb936585aa0859477862fb7a027b78f7a9c85dead66", kill_on_drop: false }`
[INFO] [stdout] 30d7256c8bc6c1ea3b23deb936585aa0859477862fb7a027b78f7a9c85dead66
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 52e623c92ad63694b669406d44b5795e569ac6dc8f0082a56971a39cf751e873
[INFO] running `Command { std: "docker" "start" "-a" "52e623c92ad63694b669406d44b5795e569ac6dc8f0082a56971a39cf751e873", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling parking_lot v0.12.4
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling serde_json v1.0.140
[INFO] [stderr]    Compiling indexmap v2.10.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling tokio v1.45.1
[INFO] [stderr]    Compiling anstyle-query v1.1.3
[INFO] [stderr]    Compiling anstream v0.6.19
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling url v2.5.4
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling time v0.3.41
[INFO] [stderr]    Compiling num-iter v0.1.45
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling proc-macro-error-attr2 v2.0.0
[INFO] [stderr]    Compiling rustversion v1.0.21
[INFO] [stderr]    Compiling clap_derive v4.5.40
[INFO] [stderr]    Compiling clap_builder v4.5.40
[INFO] [stderr]    Compiling proc-macro-error2 v2.0.1
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling bit-set v0.5.3
[INFO] [stderr]    Compiling num v0.4.3
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling data-encoding v2.9.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling tungstenite v0.24.0
[INFO] [stderr]    Compiling fancy-regex v0.13.0
[INFO] [stderr]    Compiling fraction v0.15.3
[INFO] [stderr]    Compiling clap v4.5.40
[INFO] [stderr]    Compiling validator_derive v0.20.0
[INFO] [stderr]    Compiling tokio-util v0.7.15
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling h2 v0.4.11
[INFO] [stderr]    Compiling tower-http v0.6.6
[INFO] [stderr]    Compiling uuid v1.17.0
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling bytecount v0.6.9
[INFO] [stderr]    Compiling iso8601 v0.6.3
[INFO] [stderr]    Compiling num-cmp v0.1.0
[INFO] [stderr]    Compiling axum-core v0.4.5
[INFO] [stderr]    Compiling dirs-sys v0.4.1
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling validator v0.20.0
[INFO] [stderr]    Compiling tokio-tungstenite v0.24.0
[INFO] [stderr]    Compiling simple_asn1 v0.6.3
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling pem v3.0.5
[INFO] [stderr]    Compiling serde_path_to_error v0.1.17
[INFO] [stderr]    Compiling tower-http v0.5.2
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling tower v0.4.13
[INFO] [stderr]    Compiling jsonwebtoken v9.3.1
[INFO] [stderr]    Compiling dirs v5.0.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling hyper v1.6.0
[INFO] [stderr]    Compiling hyper-util v0.1.14
[INFO] [stderr]    Compiling reqwest v0.12.22
[INFO] [stderr]    Compiling axum v0.7.9
[INFO] [stderr]    Compiling jsonschema v0.18.3
[INFO] [stderr]    Compiling pulseengine-mcp-protocol v0.10.0
[INFO] [stderr]    Compiling pulseengine-mcp-security-middleware v0.10.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 40s
[INFO] running `Command { std: "docker" "inspect" "52e623c92ad63694b669406d44b5795e569ac6dc8f0082a56971a39cf751e873", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52e623c92ad63694b669406d44b5795e569ac6dc8f0082a56971a39cf751e873", kill_on_drop: false }`
[INFO] [stdout] 52e623c92ad63694b669406d44b5795e569ac6dc8f0082a56971a39cf751e873
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1b7987a8306511285bd8afc5e344e8c44851ee6d9c9d57f07f4f40f13ba9c20a
[INFO] running `Command { std: "docker" "start" "-a" "1b7987a8306511285bd8afc5e344e8c44851ee6d9c9d57f07f4f40f13ba9c20a", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.45.1
[INFO] [stderr]    Compiling rustix v1.0.7
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling linux-raw-sys v0.9.4
[INFO] [stderr]    Compiling tower-http v0.5.2
[INFO] [stderr]    Compiling assert_matches v1.5.0
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling tokio-util v0.7.15
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling tokio-tungstenite v0.24.0
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling tokio-test v0.4.4
[INFO] [stderr]    Compiling tower-http v0.6.6
[INFO] [stderr]    Compiling h2 v0.4.11
[INFO] [stderr]    Compiling hyper v1.6.0
[INFO] [stderr]    Compiling hyper-util v0.1.14
[INFO] [stderr]    Compiling reqwest v0.12.22
[INFO] [stderr]    Compiling axum v0.7.9
[INFO] [stderr]    Compiling jsonschema v0.18.3
[INFO] [stderr]    Compiling pulseengine-mcp-protocol v0.10.0
[INFO] [stderr]    Compiling pulseengine-mcp-security-middleware v0.10.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 45.75s
[INFO] running `Command { std: "docker" "inspect" "1b7987a8306511285bd8afc5e344e8c44851ee6d9c9d57f07f4f40f13ba9c20a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1b7987a8306511285bd8afc5e344e8c44851ee6d9c9d57f07f4f40f13ba9c20a", kill_on_drop: false }`
[INFO] [stdout] 1b7987a8306511285bd8afc5e344e8c44851ee6d9c9d57f07f4f40f13ba9c20a
[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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f9264d73747709aaf680267b4290f31da7aebb6383fc25f7f3e76c7dddd1c153
[INFO] running `Command { std: "docker" "start" "-a" "f9264d73747709aaf680267b4290f31da7aebb6383fc25f7f3e76c7dddd1c153", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.26s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pulseengine_mcp_security_middleware-b6a607ae2b3db253)
[INFO] [stdout] 
[INFO] [stdout] running 56 tests
[INFO] [stdout] test auth::tests::test_auth_context_additional_methods ... ok
[INFO] [stdout] test auth::tests::test_jwt_claims ... ok
[INFO] [stdout] test auth::tests::test_token_validator ... ok
[INFO] [stdout] test auth::tests::test_token_validator_edge_cases ... ok
[INFO] [stdout] test config::tests::test_config_summary ... ok
[INFO] [stdout] test auth::tests::test_jwt_claims_expiration ... ok
[INFO] [stdout] test config::tests::test_config_validation ... ok
[INFO] [stdout] test config::tests::test_env_config_loading ... ok
[INFO] [stdout] test config::tests::test_parse_rate_limit ... ok
[INFO] [stdout] test config::tests::test_production_config ... ok
[INFO] [stdout] test middleware::tests::test_extract_api_key_edge_cases ... ok
[INFO] [stdout] test middleware::tests::test_extract_bearer_token ... ok
[INFO] [stdout] test middleware::tests::test_extract_bearer_token_edge_cases ... ok
[INFO] [stdout] test middleware::tests::test_development_middleware ... ok
[INFO] [stdout] test middleware::tests::test_rate_limiter ... ok
[INFO] [stdout] test config::tests::test_development_config ... ok
[INFO] [stdout] test profiles::tests::test_cors_configs ... ok
[INFO] [stdout] test profiles::tests::test_development_profile ... ok
[INFO] [stdout] test profiles::tests::test_production_profile ... ok
[INFO] [stdout] test auth::tests::test_auth_context_creation ... ok
[INFO] [stdout] test auth::tests::test_api_key_validator ... ok
[INFO] [stdout] test middleware::tests::test_extract_api_key ... ok
[INFO] [stdout] test middleware::tests::test_is_https_request ... ok
[INFO] [stdout] test middleware::tests::test_is_https_request_edge_cases ... ok
[INFO] [stdout] test profiles::tests::test_rate_limit_configs ... ok
[INFO] [stdout] test config::tests::test_config_builder_methods ... ok
[INFO] [stdout] test profiles::tests::test_security_profile_parsing ... ok
[INFO] [stdout] test profiles::tests::test_security_settings_for_profiles ... ok
[INFO] [stdout] test tests::test_env_security_with_invalid_profile ... ok
[INFO] [stdout] test tests::test_dev_security_creation ... ok
[INFO] [stdout] test tests::test_additional_utility_functions ... ok
[INFO] [stdout] test profiles::tests::test_staging_profile ... ok
[INFO] [stdout] test profiles::tests::test_security_settings_validation ... ok
[INFO] [stdout] test tests::test_prod_security_creation ... ok
[INFO] [stdout] test tests::test_module_exports ... ok
[INFO] [stdout] test tests::test_env_security_with_valid_profiles ... ok
[INFO] [stdout] test tests::test_version_constant ... ok
[INFO] [stdout] test tests::test_security_config_methods ... ok
[INFO] [stdout] test tests::test_version_format ... ok
[INFO] [stdout] test profiles::tests::test_security_profile_display ... ok
[INFO] [stdout] test utils::tests::test_generate_api_key ... ok
[INFO] [stdout] test utils::tests::test_generate_jwt_secret ... ok
[INFO] [stdout] test utils::tests::test_hash_and_verify_api_key ... ok
[INFO] [stdout] test utils::tests::test_hash_and_verify_consistency ... ok
[INFO] [stdout] test utils::tests::test_current_timestamp ... ok
[INFO] [stdout] test utils::tests::test_secure_random ... ok
[INFO] [stdout] test utils::tests::test_session_id_generation ... ok
[INFO] [stdout] test utils::tests::test_timestamp_consistency ... ok
[INFO] [stdout] test utils::tests::test_request_id_generation ... ok
[INFO] [stdout] test utils::tests::test_validate_api_key_format ... ok
[INFO] [stdout] test utils::tests::test_secure_compare_edge_cases ... ok
[INFO] [stdout] test utils::tests::test_secure_random_edge_cases ... ok
[INFO] [stdout] test utils::tests::test_secure_compare ... ok
[INFO] [stdout] test utils::tests::test_validate_api_key_format_edge_cases ... ok
[INFO] [stdout] test tests::test_error_constructors ... ok
[INFO] [stderr]    Doc-tests pulseengine_mcp_security_middleware
[INFO] [stdout] test middleware::tests::test_rate_limiter_edge_cases ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 56 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test src/lib.rs - (line 19) - compile ... ok
[INFO] [stdout] test src/middleware.rs - middleware::mcp_auth_middleware (line 408) - compile ... ok
[INFO] [stdout] test src/lib.rs - dev_security (line 109) ... ok
[INFO] [stdout] test src/utils.rs - utils::generate_api_key (line 47) ... ok
[INFO] [stdout] test src/lib.rs - prod_security (line 124) ... ok
[INFO] [stdout] test src/utils.rs - utils::generate_jwt_secret (line 65) ... ok
[INFO] [stdout] test src/lib.rs - (line 56) ... ok
[INFO] [stdout] test src/lib.rs - env_security (line 140) ... ok
[INFO] [stdout] test src/lib.rs - (line 45) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f9264d73747709aaf680267b4290f31da7aebb6383fc25f7f3e76c7dddd1c153", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f9264d73747709aaf680267b4290f31da7aebb6383fc25f7f3e76c7dddd1c153", kill_on_drop: false }`
[INFO] [stdout] f9264d73747709aaf680267b4290f31da7aebb6383fc25f7f3e76c7dddd1c153