[INFO] cloning repository https://github.com/karnaukhovlad/OrderingAdapter [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/karnaukhovlad/OrderingAdapter" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkarnaukhovlad%2FOrderingAdapter", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkarnaukhovlad%2FOrderingAdapter'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 6356eaf0e27fd5d846a90524162c459c17581f27 [INFO] testing karnaukhovlad/OrderingAdapter against master#e9385f9eea0221ef295a188d49d16f8f5189abf1 for pr-146098 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkarnaukhovlad%2FOrderingAdapter" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/karnaukhovlad/OrderingAdapter [INFO] finished tweaking git repo https://github.com/karnaukhovlad/OrderingAdapter [INFO] tweaked toml for git repo https://github.com/karnaukhovlad/OrderingAdapter written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/karnaukhovlad/OrderingAdapter on toolchain e9385f9eea0221ef295a188d49d16f8f5189abf1 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/karnaukhovlad/OrderingAdapter 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" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded jiff-static v0.2.13 [INFO] [stderr] Downloaded jiff v0.2.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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 94816ff6fb10a0a4c667f6ea2c9734b5de993083d75d64c3e68e1bd2eb234387 [INFO] running `Command { std: "docker" "start" "-a" "94816ff6fb10a0a4c667f6ea2c9734b5de993083d75d64c3e68e1bd2eb234387", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "94816ff6fb10a0a4c667f6ea2c9734b5de993083d75d64c3e68e1bd2eb234387", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "94816ff6fb10a0a4c667f6ea2c9734b5de993083d75d64c3e68e1bd2eb234387", kill_on_drop: false }` [INFO] [stdout] 94816ff6fb10a0a4c667f6ea2c9734b5de993083d75d64c3e68e1bd2eb234387 [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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 03c4bdf48f38c51cd3e6872f5ee5fb42dd0f46d6cb6ea754061cc0527253be0c [INFO] running `Command { std: "docker" "start" "-a" "03c4bdf48f38c51cd3e6872f5ee5fb42dd0f46d6cb6ea754061cc0527253be0c", kill_on_drop: false }` [INFO] [stderr] Compiling getrandom v0.3.3 [INFO] [stderr] Compiling zerocopy v0.8.25 [INFO] [stderr] Compiling regex-syntax v0.8.5 [INFO] [stderr] Compiling smallvec v1.15.0 [INFO] [stderr] Compiling anstyle-parse v0.2.6 [INFO] [stderr] Compiling syn v2.0.101 [INFO] [stderr] Compiling colorchoice v1.0.3 [INFO] [stderr] Compiling anstyle v1.0.10 [INFO] [stderr] Compiling anstyle-query v1.1.2 [INFO] [stderr] Compiling jiff v0.2.13 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling anstream v0.6.18 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling bs58 v0.5.1 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling rand v0.9.1 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling env_filter v0.1.3 [INFO] [stderr] Compiling tokio v1.45.0 [INFO] [stderr] Compiling env_logger v0.11.8 [INFO] [stderr] Compiling ordering_adapter v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 40.31s [INFO] running `Command { std: "docker" "inspect" "03c4bdf48f38c51cd3e6872f5ee5fb42dd0f46d6cb6ea754061cc0527253be0c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "03c4bdf48f38c51cd3e6872f5ee5fb42dd0f46d6cb6ea754061cc0527253be0c", kill_on_drop: false }` [INFO] [stdout] 03c4bdf48f38c51cd3e6872f5ee5fb42dd0f46d6cb6ea754061cc0527253be0c [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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] d839688ce323c96901cbf10c506c5fe2dc2f1ba6c3ba97c706a1dde60f96925f [INFO] running `Command { std: "docker" "start" "-a" "d839688ce323c96901cbf10c506c5fe2dc2f1ba6c3ba97c706a1dde60f96925f", kill_on_drop: false }` [INFO] [stderr] Compiling ordering_adapter v0.1.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: value assigned to `total_tx_sent` is never read [INFO] [stdout] --> src/main.rs:392:17 [INFO] [stdout] | [INFO] [stdout] 392 | let mut total_tx_sent = 0; [INFO] [stdout] | ^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = help: maybe it is overwritten before being read? [INFO] [stdout] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.45s [INFO] running `Command { std: "docker" "inspect" "d839688ce323c96901cbf10c506c5fe2dc2f1ba6c3ba97c706a1dde60f96925f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d839688ce323c96901cbf10c506c5fe2dc2f1ba6c3ba97c706a1dde60f96925f", kill_on_drop: false }` [INFO] [stdout] d839688ce323c96901cbf10c506c5fe2dc2f1ba6c3ba97c706a1dde60f96925f [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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+e9385f9eea0221ef295a188d49d16f8f5189abf1" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] a2e4849a564fa2c9850445bf12f9c4ed7e0ddd2067cdf417e9c861ef055b4909 [INFO] running `Command { std: "docker" "start" "-a" "a2e4849a564fa2c9850445bf12f9c4ed7e0ddd2067cdf417e9c861ef055b4909", kill_on_drop: false }` [INFO] [stderr] warning: value assigned to `total_tx_sent` is never read [INFO] [stderr] --> src/main.rs:392:17 [INFO] [stderr] | [INFO] [stderr] 392 | let mut total_tx_sent = 0; [INFO] [stderr] | ^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = help: maybe it is overwritten before being read? [INFO] [stderr] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: `ordering_adapter` (bin "ordering_adapter" test) generated 1 warning [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/ordering_adapter-3586263ba2b73438) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] 2025-09-28 21:49:50.573 [INFO] - Starting test_geyser_ordering_adapter [INFO] [stderr] 2025-09-28 21:49:50.573 [INFO] - [Test] Starting to receive transactions. Test timeout: 15s [INFO] [stderr] 2025-09-28 21:49:51.009 [INFO] - [Geyser] Finished sending Block: 0. Total transactions per block: 1554. Expected: 421ms, Actual: 419ms [INFO] [stderr] 2025-09-28 21:49:51.358 [INFO] - [Geyser] Finished sending Block: 1. Total transactions per block: 1864. Expected: 349ms, Actual: 349ms [INFO] [stderr] 2025-09-28 21:49:51.382 [INFO] - [Adapter] Finished processing Block: 0. Duration: 773ms. Last Index: 1553 [INFO] [stderr] 2025-09-28 21:49:51.747 [INFO] - [Adapter] Finished processing Block: 1. Duration: 360ms. Last Index: 1863 [INFO] [stderr] 2025-09-28 21:49:51.771 [INFO] - [Geyser] Finished sending Block: 2. Total transactions per block: 1548. Expected: 413ms, Actual: 412ms [INFO] [stderr] 2025-09-28 21:49:52.117 [INFO] - [Geyser] Finished sending Block: 3. Total transactions per block: 1638. Expected: 345ms, Actual: 345ms [INFO] [stderr] 2025-09-28 21:49:52.136 [INFO] - [Adapter] Finished processing Block: 2. Duration: 385ms. Last Index: 1547 [INFO] [stderr] 2025-09-28 21:49:52.506 [INFO] - [Adapter] Finished processing Block: 3. Duration: 367ms. Last Index: 1637 [INFO] [stderr] 2025-09-28 21:49:52.532 [INFO] - [Geyser] Finished sending Block: 4. Total transactions per block: 1528. Expected: 414ms, Actual: 414ms [INFO] [stderr] 2025-09-28 21:49:52.532 [INFO] - [Geyser] All 5 blocks sent. Total transactions: 8132 [INFO] [stderr] 2025-09-28 21:49:52.532 [INFO] - [Adapter] Input channel closed. Flushing remaining buffer. [INFO] [stderr] 2025-09-28 21:49:52.532 [INFO] - [Adapter] Finished processing. Total transactions sent: 8132 [INFO] [stderr] 2025-09-28 21:49:52.532 [INFO] - [Test] Successfully received all transactions. [INFO] [stderr] 2025-09-28 21:49:52.533 [INFO] - [Test] Received a total of 8132 transactions. [INFO] [stderr] 2025-09-28 21:49:52.535 [INFO] - [Test] All checks passed! [INFO] [stdout] test tests::test_geyser_ordering_adapter ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.96s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "a2e4849a564fa2c9850445bf12f9c4ed7e0ddd2067cdf417e9c861ef055b4909", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a2e4849a564fa2c9850445bf12f9c4ed7e0ddd2067cdf417e9c861ef055b4909", kill_on_drop: false }` [INFO] [stdout] a2e4849a564fa2c9850445bf12f9c4ed7e0ddd2067cdf417e9c861ef055b4909