[INFO] cloning repository https://github.com/fast/fastrace-poem [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/fast/fastrace-poem" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffast%2Ffastrace-poem", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffast%2Ffastrace-poem'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] a74b85bfecfb36c8f573a200902230e4e074d946 [INFO] testing fast/fastrace-poem against try#17092ad00ed8fe1e7f81a7e38238ff70779034b1 for pr-140985 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffast%2Ffastrace-poem" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/fast/fastrace-poem on toolchain 17092ad00ed8fe1e7f81a7e38238ff70779034b1 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] removed /workspace/builds/worker-3-tc2/source/rust-toolchain.toml [INFO] started tweaking git repo https://github.com/fast/fastrace-poem [INFO] finished tweaking git repo https://github.com/fast/fastrace-poem [INFO] tweaked toml for git repo https://github.com/fast/fastrace-poem written to /workspace/builds/worker-3-tc2/source/Cargo.toml [INFO] crate git repo https://github.com/fast/fastrace-poem 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" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tempfile v3.19.0 [INFO] [stderr] Downloaded poem-derive v3.1.4 [INFO] [stderr] Downloaded rfc7239 v0.1.3 [INFO] [stderr] Downloaded poem v3.1.7 [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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 28b2f6bfd035ef6d49387dda621d9839331de289ec6c87d36618a96a8c5b9099 [INFO] running `Command { std: "docker" "start" "-a" "28b2f6bfd035ef6d49387dda621d9839331de289ec6c87d36618a96a8c5b9099", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "28b2f6bfd035ef6d49387dda621d9839331de289ec6c87d36618a96a8c5b9099", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "28b2f6bfd035ef6d49387dda621d9839331de289ec6c87d36618a96a8c5b9099", kill_on_drop: false }` [INFO] [stdout] 28b2f6bfd035ef6d49387dda621d9839331de289ec6c87d36618a96a8c5b9099 [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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 79000323e02e75d27bf75b023043f68e7e74dc89227391f890113b1f8266dc5c [INFO] running `Command { std: "docker" "start" "-a" "79000323e02e75d27bf75b023043f68e7e74dc89227391f890113b1f8266dc5c", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.94 [INFO] [stderr] Compiling unicode-ident v1.0.18 [INFO] [stderr] Compiling libc v0.2.171 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling bytes v1.10.1 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling typenum v1.18.0 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling hashbrown v0.15.2 [INFO] [stderr] Compiling equivalent v1.0.2 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling once_cell v1.21.1 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling zerocopy v0.8.23 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling getrandom v0.3.2 [INFO] [stderr] Compiling indexmap v2.8.0 [INFO] [stderr] Compiling smallvec v1.14.0 [INFO] [stderr] Compiling tracing-core v0.1.33 [INFO] [stderr] Compiling http v1.3.1 [INFO] [stderr] Compiling lock_api v0.4.12 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling uncased v0.9.10 [INFO] [stderr] Compiling winnow v0.7.4 [INFO] [stderr] Compiling toml_datetime v0.6.8 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling cfg_aliases v0.2.1 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling httpdate v1.0.3 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling socket2 v0.5.8 [INFO] [stderr] Compiling mio v1.0.3 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling nix v0.29.0 [INFO] [stderr] Compiling proc-macro-error-attr2 v2.0.0 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling toml_edit v0.22.24 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling cpufeatures v0.2.17 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling regex-syntax v0.8.5 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling proc-macro-error2 v2.0.1 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling headers-core v0.3.0 [INFO] [stderr] Compiling mime v0.3.17 [INFO] [stderr] Compiling small_ctor v0.1.2 [INFO] [stderr] Compiling web-time v1.1.0 [INFO] [stderr] Compiling base64 v0.21.7 [INFO] [stderr] Compiling bitflags v2.9.0 [INFO] [stderr] Compiling fastant v0.1.10 [INFO] [stderr] Compiling rand v0.9.0 [INFO] [stderr] Compiling rfc7239 v0.1.3 [INFO] [stderr] Compiling headers v0.4.0 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling proc-macro-crate v3.3.0 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling tracing-attributes v0.1.28 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling tokio v1.44.1 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling poem-derive v3.1.4 [INFO] [stderr] Compiling fastrace-macro v0.7.8 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling rtrb v0.3.2 [INFO] [stderr] Compiling wildmatch v2.4.0 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling h2 v0.4.8 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling fastrace v0.7.8 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling poem v3.1.7 [INFO] [stderr] Compiling fastrace-poem v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 52.46s [INFO] running `Command { std: "docker" "inspect" "79000323e02e75d27bf75b023043f68e7e74dc89227391f890113b1f8266dc5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "79000323e02e75d27bf75b023043f68e7e74dc89227391f890113b1f8266dc5c", kill_on_drop: false }` [INFO] [stdout] 79000323e02e75d27bf75b023043f68e7e74dc89227391f890113b1f8266dc5c [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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 5dd65a8da56a10df6b82e8f14badf4d646eacd6cc83a234ff6b69bc7701ef0e1 [INFO] running `Command { std: "docker" "start" "-a" "5dd65a8da56a10df6b82e8f14badf4d646eacd6cc83a234ff6b69bc7701ef0e1", kill_on_drop: false }` [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling shlex v1.3.0 [INFO] [stderr] Compiling pkg-config v0.3.32 [INFO] [stderr] Compiling litemap v0.7.5 [INFO] [stderr] Compiling writeable v0.5.5 [INFO] [stderr] Compiling try-lock v0.2.5 [INFO] [stderr] Compiling icu_locid_transform_data v1.5.0 [INFO] [stderr] Compiling want v0.3.1 [INFO] [stderr] Compiling icu_properties_data v1.5.0 [INFO] [stderr] Compiling openssl v0.10.71 [INFO] [stderr] Compiling cc v1.2.16 [INFO] [stderr] Compiling tower-service v0.3.3 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling write16 v1.0.0 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling utf16_iter v1.0.5 [INFO] [stderr] Compiling utf8_iter v1.0.4 [INFO] [stderr] Compiling icu_normalizer_data v1.5.0 [INFO] [stderr] Compiling native-tls v0.2.14 [INFO] [stderr] Compiling log v0.4.26 [INFO] [stderr] Compiling openssl-probe v0.1.6 [INFO] [stderr] Compiling tower-layer v0.3.3 [INFO] [stderr] Compiling rustls-pki-types v1.11.0 [INFO] [stderr] Compiling encoding_rs v0.8.35 [INFO] [stderr] Compiling ipnet v2.11.0 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling rustls-pemfile v2.2.0 [INFO] [stderr] Compiling openssl-sys v0.9.106 [INFO] [stderr] Compiling synstructure v0.13.1 [INFO] [stderr] Compiling proc-macro-error2 v2.0.1 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.7.5 [INFO] [stderr] Compiling zerovec-derive v0.10.3 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling icu_provider_macros v1.5.0 [INFO] [stderr] Compiling tracing-attributes v0.1.28 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling tokio v1.44.1 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling yoke v0.7.5 [INFO] [stderr] Compiling fastrace-macro v0.7.8 [INFO] [stderr] Compiling zerovec v0.10.4 [INFO] [stderr] Compiling poem-derive v3.1.4 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling tinystr v0.7.6 [INFO] [stderr] Compiling icu_collections v1.5.0 [INFO] [stderr] Compiling icu_locid v1.5.0 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling icu_provider v1.5.0 [INFO] [stderr] Compiling icu_locid_transform v1.5.0 [INFO] [stderr] Compiling icu_properties v1.5.1 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling fastrace v0.7.8 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling h2 v0.4.8 [INFO] [stderr] Compiling icu_normalizer v1.5.0 [INFO] [stderr] Compiling idna_adapter v1.2.0 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling poem v3.1.7 [INFO] [stderr] Compiling reqwest v0.12.14 [INFO] [stderr] Compiling fastrace-reqwest v0.1.0 (https://github.com/fast/fastrace-reqwest#b3e84a03) [INFO] [stderr] Compiling fastrace-poem v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 28s [INFO] running `Command { std: "docker" "inspect" "5dd65a8da56a10df6b82e8f14badf4d646eacd6cc83a234ff6b69bc7701ef0e1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5dd65a8da56a10df6b82e8f14badf4d646eacd6cc83a234ff6b69bc7701ef0e1", kill_on_drop: false }` [INFO] [stdout] 5dd65a8da56a10df6b82e8f14badf4d646eacd6cc83a234ff6b69bc7701ef0e1 [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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 82a8825d8506cf1f95db91cad75eab170ce734d990584f10cb6a72315a7c89e8 [INFO] running `Command { std: "docker" "start" "-a" "82a8825d8506cf1f95db91cad75eab170ce734d990584f10cb6a72315a7c89e8", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.37s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fastrace_poem-0d1f25856365965a) [INFO] [stderr] Doc-tests fastrace_poem [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] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test src/lib.rs - (line 78) ... ok [INFO] [stdout] test src/lib.rs - FastraceMiddleware (line 25) ... FAILED [INFO] [stdout] test src/lib.rs - (line 42) has been running for over 60 seconds [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "82a8825d8506cf1f95db91cad75eab170ce734d990584f10cb6a72315a7c89e8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "82a8825d8506cf1f95db91cad75eab170ce734d990584f10cb6a72315a7c89e8", kill_on_drop: false }` [INFO] [stdout] 82a8825d8506cf1f95db91cad75eab170ce734d990584f10cb6a72315a7c89e8