[INFO] fetching crate routerify_ng 0.3.1...
[INFO] testing routerify_ng-0.3.1 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate routerify_ng 0.3.1 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate routerify_ng 0.3.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate routerify_ng 0.3.1
[INFO] tweaked toml for crates.io crate routerify_ng 0.3.1 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate routerify_ng 0.3.1 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 crates.io crate routerify_ng 0.3.1 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 52078f71ca1d9f8afd648bf62525db633b0a6dc97bc7b76799ec652dc244654e
[INFO] running `Command { std: "docker" "start" "-a" "52078f71ca1d9f8afd648bf62525db633b0a6dc97bc7b76799ec652dc244654e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "52078f71ca1d9f8afd648bf62525db633b0a6dc97bc7b76799ec652dc244654e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52078f71ca1d9f8afd648bf62525db633b0a6dc97bc7b76799ec652dc244654e", kill_on_drop: false }`
[INFO] [stdout] 52078f71ca1d9f8afd648bf62525db633b0a6dc97bc7b76799ec652dc244654e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 3e24e71553e63851f839036a3d159ffc1feb3961c429cb15fdfaf040aa2025ca
[INFO] running `Command { std: "docker" "start" "-a" "3e24e71553e63851f839036a3d159ffc1feb3961c429cb15fdfaf040aa2025ca", kill_on_drop: false }`
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling routerify_ng v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 16.69s
[INFO] running `Command { std: "docker" "inspect" "3e24e71553e63851f839036a3d159ffc1feb3961c429cb15fdfaf040aa2025ca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e24e71553e63851f839036a3d159ffc1feb3961c429cb15fdfaf040aa2025ca", kill_on_drop: false }`
[INFO] [stdout] 3e24e71553e63851f839036a3d159ffc1feb3961c429cb15fdfaf040aa2025ca
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 897ccf2182796e894ecef514bc4aa55ccde6e77bf3eaacff423dfe4eee360141
[INFO] running `Command { std: "docker" "start" "-a" "897ccf2182796e894ecef514bc4aa55ccde6e77bf3eaacff423dfe4eee360141", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling routerify_ng v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 49.49s
[INFO] running `Command { std: "docker" "inspect" "897ccf2182796e894ecef514bc4aa55ccde6e77bf3eaacff423dfe4eee360141", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "897ccf2182796e894ecef514bc4aa55ccde6e77bf3eaacff423dfe4eee360141", kill_on_drop: false }`
[INFO] [stdout] 897ccf2182796e894ecef514bc4aa55ccde6e77bf3eaacff423dfe4eee360141
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 9b195d27b78a11cc522f1970837142a8549216b8877d5df654cbbbee12152d2a
[INFO] running `Command { std: "docker" "start" "-a" "9b195d27b78a11cc522f1970837142a8549216b8877d5df654cbbbee12152d2a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.22s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/routerify_ng-78284b88a263158f)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test helpers::tests::test_percent_decode_request_path ... ok
[INFO] [stdout] test regex_generator::tests::test_generate_common_regex_str_special_character ... ok
[INFO] [stdout] test regex_generator::tests::test_generate_common_regex_str_normal ... ok
[INFO] [stdout] test regex_generator::tests::test_generate_common_regex_str_star_globe ... ok
[INFO] [stdout] test regex_generator::tests::test_generate_common_regex_str_params ... ok
[INFO] [stderr]      Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-1e28e1b107635e1e)
[INFO] [stdout] test service::request_service::tests::should_route_request ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test can_perform_simple_get_request ... ok
[INFO] [stdout] test can_propagate_request_context ... ok
[INFO] [stdout] test can_extract_path_params ... ok
[INFO] [stdout] test execute_scoped_middleware_when_no_unscoped_match ... ok
[INFO] [stdout] test can_extract_extension_path_params_1 ... ok
[INFO] [stdout] test can_perform_simple_get_request_boxed_error ... ok
[INFO] [stdout] test can_extract_extension_path_params_2 ... ok
[INFO] [stdout] test do_not_execute_scoped_middleware_for_unscoped_path ... ok
[INFO] [stdout] test can_respond_with_data_from_scope_state ... ok
[INFO] [stdout] test can_handle_pre_middleware_errors ... ok
[INFO] [stdout] test can_handle_custom_errors ... ok
[INFO] [stdout] test unknown_method_falls_back_to_get ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests routerify_ng
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test src/ext/request.rs - ext::request::RequestExt::param (line 43) ... ok
[INFO] [stdout] test src/ext/request.rs - ext::request::RequestExt::params (line 12) ... ok
[INFO] [stdout] test src/lib.rs - (line 40) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 173) ... ok
[INFO] [stdout] test src/lib.rs - (line 223) ... ok
[INFO] [stdout] test src/lib.rs - (line 288) ... ok
[INFO] [stdout] test src/lib.rs - (line 670) ... ok
[INFO] [stdout] test src/lib.rs - (line 556) ... ok
[INFO] [stdout] test src/lib.rs - (line 740) ... ok
[INFO] [stdout] test src/lib.rs - (line 475) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::post (line 63) ... ok
[INFO] [stdout] test src/lib.rs - (line 202) ... ok
[INFO] [stdout] test src/lib.rs - (line 506) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::post_with_path (line 162) ... ok
[INFO] [stdout] test src/lib.rs - (line 377) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::post_with_info (line 92) ... ok
[INFO] [stdout] test src/lib.rs - (line 411) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::pre_with_path (line 130) ... ok
[INFO] [stdout] test src/middleware/post.rs - middleware::post::PostMiddleware<E>::new (line 68) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::post_with_info_with_path (line 195) ... ok
[INFO] [stdout] test src/middleware/mod.rs - middleware::Middleware<E>::pre (line 35) ... ok
[INFO] [stdout] test src/middleware/post.rs - middleware::post::PostMiddleware<E>::new_with_info (line 102) ... ok
[INFO] [stdout] test src/lib.rs - (line 619) ... ok
[INFO] [stdout] test src/lib.rs - (line 708) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder (line 26) - compile ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::connect (line 313) ... ok
[INFO] [stdout] test src/lib.rs - (line 442) ... ok
[INFO] [stdout] test src/lib.rs - (line 322) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::any (line 407) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::any_method (line 447) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::delete (line 222) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::head (line 255) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::middleware (line 651) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::scope (line 527) ... ok
[INFO] [stdout] test src/router/mod.rs - router::Router (line 43) ... ok
[INFO] [stdout] test src/service/router_service.rs - service::router_service::RouterService (line 19) - compile ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::trace (line 283) ... ok
[INFO] [stdout] test src/types/route_params.rs - types::route_params::RouteParams::get (line 32) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::options (line 376) ... ok
[INFO] [stdout] test src/types/request_info.rs - types::request_info::RequestInfo::context (line 86) ... ok
[INFO] [stdout] test src/lib.rs - (line 150) ... ok
[INFO] [stdout] test src/types/route_params.rs - types::route_params::RouteParams::has (line 66) ... ok
[INFO] [stdout] test src/ext/request.rs - ext::request::RequestExt::remote_addr (line 74) ... ok
[INFO] [stdout] test src/middleware/pre.rs - middleware::pre::PreMiddleware<E>::new (line 56) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::get (line 115) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::put (line 194) ... ok
[INFO] [stdout] test src/route/mod.rs - route::Route (line 30) ... ok
[INFO] [stdout] test src/ext/request.rs - ext::request::RequestExt::set_context (line 112) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::patch (line 343) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::post (line 168) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::get_or_head (line 142) ... ok
[INFO] [stdout] test src/lib.rs - (line 248) ... ok
[INFO] [stdout] test src/router/builder.rs - router::builder::RouterBuilder<E>::add (line 481) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 3.38s; merged doctests compilation took 3.23s
[INFO] running `Command { std: "docker" "inspect" "9b195d27b78a11cc522f1970837142a8549216b8877d5df654cbbbee12152d2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9b195d27b78a11cc522f1970837142a8549216b8877d5df654cbbbee12152d2a", kill_on_drop: false }`
[INFO] [stdout] 9b195d27b78a11cc522f1970837142a8549216b8877d5df654cbbbee12152d2a