[INFO] fetching crate ic-agent 0.39.3... [INFO] testing ic-agent-0.39.3 against master#ebf0cf75d368c035f4c7e7246d203bd469ee4a51 for pr-137940-2 [INFO] extracting crate ic-agent 0.39.3 into /workspace/builds/worker-1-tc1/source [INFO] validating manifest of crates.io crate ic-agent 0.39.3 on toolchain ebf0cf75d368c035f4c7e7246d203bd469ee4a51 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate ic-agent 0.39.3 [INFO] finished tweaking crates.io crate ic-agent 0.39.3 [INFO] tweaked toml for crates.io crate ic-agent 0.39.3 written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Locking 297 packages to latest compatible versions [INFO] [stderr] Adding async-channel v1.9.0 (available: v2.3.1) [INFO] [stderr] Adding cached v0.52.0 (available: v0.55.1) [INFO] [stderr] Adding getrandom v0.2.15 (available: v0.3.1) [INFO] [stderr] Adding ic-verify-bls-signature v0.5.0 (available: v0.6.0) [INFO] [stderr] Adding rand v0.8.5 (available: v0.9.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "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 stop-token v0.7.0 [INFO] [stderr] Downloaded wasm-bindgen-test v0.3.50 [INFO] [stderr] Downloaded windows-targets v0.53.0 [INFO] [stderr] Downloaded opaque-debug v0.3.1 [INFO] [stderr] Downloaded subtle-ng v2.5.0 [INFO] [stderr] Downloaded async-watch v0.3.1 [INFO] [stderr] Downloaded async-trait v0.1.88 [INFO] [stderr] Downloaded arc-swap v1.7.1 [INFO] [stderr] Downloaded cached v0.52.0 [INFO] [stderr] Downloaded rand v0.9.0 [INFO] [stderr] Downloaded k256 v0.13.4 [INFO] [stderr] Downloaded tokio-util v0.7.14 [INFO] [stderr] Downloaded num-bigint v0.4.6 [INFO] [stderr] Downloaded time v0.3.39 [INFO] [stderr] Downloaded h2 v0.4.8 [INFO] [stderr] Downloaded http v1.3.1 [INFO] [stderr] Downloaded reqwest v0.12.14 [INFO] [stderr] Downloaded zerocopy v0.8.23 [INFO] [stderr] Downloaded quinn-proto v0.11.9 [INFO] [stderr] Downloaded webpki-roots v0.26.8 [INFO] [stderr] Downloaded indexmap v2.8.0 [INFO] [stderr] Downloaded zerocopy-derive v0.8.23 [INFO] [stderr] Downloaded quinn v0.11.6 [INFO] [stderr] Downloaded candid v0.10.13 [INFO] [stderr] Downloaded half v1.8.3 [INFO] [stderr] Downloaded serde_cbor v0.11.2 [INFO] [stderr] Downloaded serde_derive v1.0.219 [INFO] [stderr] Downloaded similar v2.7.0 [INFO] [stderr] Downloaded mockito v1.7.0 [INFO] [stderr] Downloaded ff v0.13.1 [INFO] [stderr] Downloaded rangemap v1.5.1 [INFO] [stderr] Downloaded tinyvec v1.9.0 [INFO] [stderr] Downloaded quinn-udp v0.5.10 [INFO] [stderr] Downloaded curve25519-dalek-ng v4.1.1 [INFO] [stderr] Downloaded base64ct v1.7.3 [INFO] [stderr] Downloaded event-listener v2.5.3 [INFO] [stderr] Downloaded ic_bls12_381 v0.10.1 [INFO] [stderr] Downloaded time-core v0.1.3 [INFO] [stderr] Downloaded minicov v0.3.7 [INFO] [stderr] Downloaded binread v2.2.0 [INFO] [stderr] Downloaded candid_derive v0.6.6 [INFO] [stderr] Downloaded data-encoding v2.8.0 [INFO] [stderr] Downloaded arrayvec v0.5.2 [INFO] [stderr] Downloaded pretty v0.12.4 [INFO] [stderr] Downloaded windows_aarch64_gnullvm v0.53.0 [INFO] [stderr] Downloaded ic-certification v3.0.3 [INFO] [stderr] Downloaded ic-transport-types v0.39.3 [INFO] [stderr] Downloaded tokio v1.44.1 [INFO] [stderr] Downloaded windows_aarch64_msvc v0.53.0 [INFO] [stderr] Downloaded windows_i686_gnullvm v0.53.0 [INFO] [stderr] Downloaded windows_x86_64_msvc v0.53.0 [INFO] [stderr] Downloaded windows_x86_64_gnullvm v0.53.0 [INFO] [stderr] Downloaded windows_x86_64_gnu v0.53.0 [INFO] [stderr] Downloaded colored v3.0.0 [INFO] [stderr] Downloaded windows_i686_msvc v0.53.0 [INFO] [stderr] Downloaded windows_i686_gnu v0.53.0 [INFO] [stderr] Downloaded rand_core v0.9.3 [INFO] [stderr] Downloaded ppv-lite86 v0.2.21 [INFO] [stderr] Downloaded simple_asn1 v0.6.3 [INFO] [stderr] Downloaded time-macros v0.2.20 [INFO] [stderr] Downloaded sha2 v0.9.9 [INFO] [stderr] Downloaded either v1.15.0 [INFO] [stderr] Downloaded binread_derive v2.1.0 [INFO] [stderr] Downloaded typed-arena v2.0.2 [INFO] [stderr] Downloaded psm v0.1.25 [INFO] [stderr] Downloaded stacker v0.1.19 [INFO] [stderr] Downloaded pairing v0.23.0 [INFO] [stderr] Downloaded leb128 v0.2.5 [INFO] [stderr] Downloaded assert-json-diff v2.0.2 [INFO] [stderr] Downloaded rand_chacha v0.9.0 [INFO] [stderr] Downloaded http-body-util v0.1.3 [INFO] [stderr] Downloaded windows-result v0.3.1 [INFO] [stderr] Downloaded windows-strings v0.3.1 [INFO] [stderr] Downloaded windows-registry v0.4.0 [INFO] [stderr] Downloaded serde_bytes v0.11.17 [INFO] [stderr] Downloaded serde_repr v0.1.20 [INFO] [stderr] Downloaded async-channel v1.9.0 [INFO] [stderr] Downloaded wasm-bindgen-test-macro v0.3.50 [INFO] [stderr] Downloaded ed25519-consensus v2.1.0 [INFO] [stderr] Downloaded ic_principal v0.1.1 [INFO] [stderr] Downloaded ic-verify-bls-signature v0.5.0 [INFO] [stderr] Downloaded ring v0.17.14 [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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 23c5d7e29a10debd39b037d762f3847a904d08658106bbf05e7d4bc1552f043e [INFO] running `Command { std: "docker" "start" "-a" "23c5d7e29a10debd39b037d762f3847a904d08658106bbf05e7d4bc1552f043e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "23c5d7e29a10debd39b037d762f3847a904d08658106bbf05e7d4bc1552f043e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "23c5d7e29a10debd39b037d762f3847a904d08658106bbf05e7d4bc1552f043e", kill_on_drop: false }` [INFO] [stdout] 23c5d7e29a10debd39b037d762f3847a904d08658106bbf05e7d4bc1552f043e [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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1d43238660860fef6015025f16a73cc002b78e90bd25b032f9bb9f310e7b0ebb [INFO] running `Command { std: "docker" "start" "-a" "1d43238660860fef6015025f16a73cc002b78e90bd25b032f9bb9f310e7b0ebb", 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 version_check v0.9.5 [INFO] [stderr] Compiling zeroize v1.8.1 [INFO] [stderr] Compiling typenum v1.18.0 [INFO] [stderr] Compiling subtle v2.6.1 [INFO] [stderr] Compiling shlex v1.3.0 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling bytes v1.10.1 [INFO] [stderr] Compiling once_cell v1.21.1 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling base64ct v1.7.3 [INFO] [stderr] Compiling cpufeatures v0.2.17 [INFO] [stderr] Compiling writeable v0.5.5 [INFO] [stderr] Compiling litemap v0.7.5 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling cc v1.2.16 [INFO] [stderr] Compiling smallvec v1.14.0 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling pem-rfc7468 v0.7.0 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling zerocopy v0.8.23 [INFO] [stderr] Compiling icu_locid_transform_data v1.5.0 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling rustls-pki-types v1.11.0 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling der v0.7.9 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling icu_properties_data v1.5.0 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling base16ct v0.2.0 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling http v1.3.1 [INFO] [stderr] Compiling concurrent-queue v2.5.0 [INFO] [stderr] Compiling icu_normalizer_data v1.5.0 [INFO] [stderr] Compiling rustls v0.23.23 [INFO] [stderr] Compiling write16 v1.0.0 [INFO] [stderr] Compiling try-lock v0.2.5 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling utf8_iter v1.0.4 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling rustversion v1.0.20 [INFO] [stderr] Compiling utf16_iter v1.0.5 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling want v0.3.1 [INFO] [stderr] Compiling ahash v0.8.11 [INFO] [stderr] Compiling tracing-core v0.1.33 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling paste v1.0.15 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling tower-service v0.3.3 [INFO] [stderr] Compiling getrandom v0.2.15 [INFO] [stderr] Compiling socket2 v0.5.8 [INFO] [stderr] Compiling mio v1.0.3 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling anyhow v1.0.97 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling ff v0.13.1 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling spki v0.7.3 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling psm v0.1.25 [INFO] [stderr] Compiling group v0.13.0 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling tokio v1.44.1 [INFO] [stderr] Compiling pkcs8 v0.10.2 [INFO] [stderr] Compiling stacker v0.1.19 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling crc32fast v1.4.2 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling sec1 v0.7.3 [INFO] [stderr] Compiling crypto-bigint v0.5.5 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling typed-arena v2.0.2 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling zerocopy v0.7.35 [INFO] [stderr] Compiling data-encoding v2.8.0 [INFO] [stderr] Compiling time-core v0.1.3 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling unicode-width v0.1.14 [INFO] [stderr] Compiling parking v2.2.1 [INFO] [stderr] Compiling num-conv v0.1.0 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling signature v2.2.0 [INFO] [stderr] Compiling rfc6979 v0.4.0 [INFO] [stderr] Compiling deranged v0.3.11 [INFO] [stderr] Compiling event-listener v5.4.0 [INFO] [stderr] Compiling time-macros v0.2.20 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling pairing v0.23.0 [INFO] [stderr] Compiling pretty v0.12.4 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling webpki-roots v0.26.8 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling instant v0.1.13 [INFO] [stderr] Compiling allocator-api2 v0.2.21 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling opaque-debug v0.3.1 [INFO] [stderr] Compiling leb128 v0.2.5 [INFO] [stderr] Compiling tower-layer v0.3.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling subtle-ng v2.5.0 [INFO] [stderr] Compiling half v1.8.3 [INFO] [stderr] Compiling curve25519-dalek-ng v4.1.1 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling event-listener-strategy v0.5.3 [INFO] [stderr] Compiling ic_bls12_381 v0.10.1 [INFO] [stderr] Compiling async-channel v1.9.0 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling rustls-pemfile v2.2.0 [INFO] [stderr] Compiling mime v0.3.17 [INFO] [stderr] Compiling log v0.4.26 [INFO] [stderr] Compiling ipnet v2.11.0 [INFO] [stderr] Compiling stop-token v0.7.0 [INFO] [stderr] Compiling pem v3.0.5 [INFO] [stderr] Compiling async-lock v3.4.0 [INFO] [stderr] Compiling async-watch v0.3.1 [INFO] [stderr] Compiling arc-swap v1.7.1 [INFO] [stderr] Compiling rangemap v1.5.1 [INFO] [stderr] Compiling elliptic-curve v0.13.8 [INFO] [stderr] Compiling ic-verify-bls-signature v0.5.0 [INFO] [stderr] Compiling backoff v0.4.0 [INFO] [stderr] Compiling ecdsa v0.16.9 [INFO] [stderr] Compiling primeorder v0.13.6 [INFO] [stderr] Compiling time v0.3.39 [INFO] [stderr] Compiling k256 v0.13.4 [INFO] [stderr] Compiling p256 v0.13.2 [INFO] [stderr] Compiling synstructure v0.13.1 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.7.5 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling zerovec-derive v0.10.3 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling icu_provider_macros v1.5.0 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling candid_derive v0.6.6 [INFO] [stderr] Compiling serde_repr v0.1.20 [INFO] [stderr] Compiling binread_derive v2.1.0 [INFO] [stderr] Compiling async-trait v0.1.88 [INFO] [stderr] Compiling rustls-webpki v0.102.8 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling cached v0.52.0 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.7.5 [INFO] [stderr] Compiling binread v2.2.0 [INFO] [stderr] Compiling zerovec v0.10.4 [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 icu_provider v1.5.0 [INFO] [stderr] Compiling icu_locid_transform v1.5.0 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling icu_properties v1.5.1 [INFO] [stderr] Compiling tokio-rustls v0.26.2 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling hyper-rustls v0.27.5 [INFO] [stderr] Compiling num-bigint v0.4.6 [INFO] [stderr] Compiling serde_bytes v0.11.17 [INFO] [stderr] Compiling ic_principal v0.1.1 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling ed25519-consensus v2.1.0 [INFO] [stderr] Compiling ic-certification v3.0.3 [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 candid v0.10.13 [INFO] [stderr] Compiling simple_asn1 v0.6.3 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling reqwest v0.12.14 [INFO] [stderr] Compiling ic-transport-types v0.39.3 [INFO] [stderr] Compiling ic-agent v0.39.3 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 07s [INFO] running `Command { std: "docker" "inspect" "1d43238660860fef6015025f16a73cc002b78e90bd25b032f9bb9f310e7b0ebb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1d43238660860fef6015025f16a73cc002b78e90bd25b032f9bb9f310e7b0ebb", kill_on_drop: false }` [INFO] [stdout] 1d43238660860fef6015025f16a73cc002b78e90bd25b032f9bb9f310e7b0ebb [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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 465a370a67c150fd47ccb79ad39f4c164c224d1d0c2f379baab0779d05e975cb [INFO] running `Command { std: "docker" "start" "-a" "465a370a67c150fd47ccb79ad39f4c164c224d1d0c2f379baab0779d05e975cb", kill_on_drop: false }` [INFO] [stderr] Compiling tracing-core v0.1.33 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling tracing-attributes v0.1.28 [INFO] [stderr] Compiling hashbrown v0.15.2 [INFO] [stderr] Compiling equivalent v1.0.2 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling httpdate v1.0.3 [INFO] [stderr] Compiling getrandom v0.3.1 [INFO] [stderr] Compiling log v0.4.26 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling regex-syntax v0.8.5 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling thread_local v1.1.8 [INFO] [stderr] Compiling similar v2.7.0 [INFO] [stderr] Compiling colored v3.0.0 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling tokio v1.44.1 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling rand v0.9.0 [INFO] [stderr] Compiling indexmap v2.8.0 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling tokio-rustls v0.26.2 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling h2 v0.4.8 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling hyper-rustls v0.27.5 [INFO] [stderr] Compiling mockito v1.7.0 [INFO] [stderr] Compiling reqwest v0.12.14 [INFO] [stderr] Compiling ic-agent v0.39.3 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 30.30s [INFO] running `Command { std: "docker" "inspect" "465a370a67c150fd47ccb79ad39f4c164c224d1d0c2f379baab0779d05e975cb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "465a370a67c150fd47ccb79ad39f4c164c224d1d0c2f379baab0779d05e975cb", kill_on_drop: false }` [INFO] [stdout] 465a370a67c150fd47ccb79ad39f4c164c224d1d0c2f379baab0779d05e975cb [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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c79dad4c7b884c7262a525938e666d85e66a8ebb9dfbfa3094998685b0864824 [INFO] running `Command { std: "docker" "start" "-a" "c79dad4c7b884c7262a525938e666d85e66a8ebb9dfbfa3094998685b0864824", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.40s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ic_agent-d79ebfc5ed9791d1) [INFO] [stdout] [INFO] [stdout] running 56 tests [INFO] [stdout] test agent::agent_error::tests::formats_text_html ... ok [INFO] [stdout] test agent::agent_error::tests::content_type_none_valid_utf8 ... ok [INFO] [stdout] test agent::agent_error::tests::formats_text_plain ... ok [INFO] [stdout] test agent::agent_error::tests::content_type_none_invalid_utf8 ... ok [INFO] [stdout] test agent::agent_error::tests::formats_text_plain_charset_utf8 ... ok [INFO] [stdout] test agent::agent_test::query ... ok [INFO] [stdout] test agent::agent_test::call_rejected_without_error_code ... ok [INFO] [stdout] test agent::agent_test::status ... ok [INFO] [stdout] test agent::agent_test::call_rejected ... ok [INFO] [stdout] test agent::agent_test::status_okay ... ok [INFO] [stdout] test agent::agent_test::query_rejected ... ok [INFO] [stdout] test agent::agent_test::query_error ... ok [INFO] [stdout] test agent::agent_test::check_subnet_range_with_pruned_range ... ok [INFO] [stdout] test agent::agent_test::reqwest_client_status_okay_when_request_retried ... ok [INFO] [stdout] test agent::offline_tests::rounded_expiry ... ok [INFO] [stdout] test agent::agent_test::call_error ... ok [INFO] [stdout] test agent::agent_test::status_error ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_compute_score_with_penalty ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_snapshot_init ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_stats_for_next_n_nodes ... ignored [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_sync_node_scenarios ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_update_for_existing_node_succeeds ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_update_for_non_existing_node_fails ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::latency_based_routing::tests::test_weighted_sample ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_n_nodes ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_snapshot_init ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_sync_node_scenarios ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_update_of_existing_healthy_node_with_unhealthy_node_returns_true ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_update_of_existing_unhealthy_node_with_healthy_node_returns_true ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_update_of_non_existing_node_always_returns_false ... ok [INFO] [stdout] test agent::route_provider::tests::test_empty_routes ... ok [INFO] [stdout] test agent::route_provider::tests::test_n_routes ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::snapshot::round_robin_routing::tests::test_next_node ... ok [INFO] [stdout] test agent::route_provider::tests::test_routes_rotation ... ok [INFO] [stdout] test identity::prime256v1::test::test_prime256v1_public_key ... ok [INFO] [stdout] test agent::agent_test::check_subnet_range_with_unauthorized_range ... ok [INFO] [stdout] test agent::agent_test::wrong_subnet_query_certificate ... ok [INFO] [stdout] test identity::prime256v1::test::test_prime256v1_signature ... ok [INFO] [stdout] test identity::secp256k1::test::test_secp256k1_public_key ... ok [INFO] [stdout] test identity::prime256v1::test::test_prime256v1_reject_wrong_curve - should panic ... ok [INFO] [stdout] test identity::prime256v1::test::test_prime256v1_reject_wrong_curve_no_id - should panic ... ok [INFO] [stdout] test identity::secp256k1::test::test_secp256k1_reject_wrong_curve - should panic ... ok [INFO] [stdout] test identity::secp256k1::test::test_secp256k1_reject_wrong_curve_no_id - should panic ... ok [INFO] [stdout] test agent::agent_test::check_subnet_range_with_valid_range ... ok [INFO] [stdout] test agent::agent_test::too_many_delegations ... ok [INFO] [stdout] test identity::secp256k1::test::test_secp256k1_signature ... ok [INFO] [stdout] test agent::agent_test::no_cert ... ok [INFO] [stdout] test agent::offline_tests::client_ratelimit ... ok [INFO] [stdout] test agent::agent_test::retry_ratelimit ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_route_with_one_healthy_and_one_unhealthy_seed ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_routing_with_no_healthy_nodes_returns_an_error ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_route_with_no_healthy_seeds_errors ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_route_with_initially_unhealthy_seeds_becoming_healthy ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_routing_with_an_empty_fetched_list_of_api_nodes ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_routing_with_topology_and_node_health_updates ... ok [INFO] [stdout] test agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet stdout ---- [INFO] [stdout] 2025-03-17T08:44:01.650772Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:01.650874Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:01.650910Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:01.655180Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:01.655277Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:01.655303Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:01.655334Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:01.655564Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:02.656682Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:02.656746Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:02.656787Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:02.657199Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:02.657302Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:02.657328Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:02.657352Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:02.657565Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:03.659241Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:03.659309Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:03.659365Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:03.659741Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:03.659863Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:03.659889Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:03.659913Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:03.661969Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:04.662623Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:04.662688Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:04.662745Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:04.663202Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:04.663320Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:04.663347Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:04.663371Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:04.663647Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:05.665217Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:05.665283Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:05.665350Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:05.665826Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:05.665964Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:05.665993Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:05.666020Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:05.666314Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:06.667550Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:06.667616Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:06.667656Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:06.668063Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:06.668161Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:06.668186Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:06.668209Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:06.668495Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:07.670186Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:07.670258Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:07.670299Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:07.670770Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:07.670896Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:07.670921Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:07.670942Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:07.671295Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:08.672534Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:08.672596Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:08.672637Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:08.673044Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:08.673147Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:08.673171Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:08.673191Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:08.673413Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:09.675231Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:09.675292Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:09.675331Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:09.675828Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:09.675957Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:09.675982Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:09.676003Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:09.676325Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:10.677702Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:10.677766Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:10.677808Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:10.678205Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:10.678305Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:10.678329Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:10.678351Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:10.678640Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:11.680298Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:11.680359Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:11.680402Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:11.680899Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:11.681011Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:11.681037Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:11.681060Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:11.681353Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:12.682695Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:12.682768Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:12.682807Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:12.683204Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:12.683310Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:12.683334Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:12.683356Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:12.683626Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:13.685264Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:13.685327Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:13.685367Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:13.685748Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:13.685864Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:13.685888Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:13.685907Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:13.686163Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:14.687589Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:14.687652Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:14.687693Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:14.688122Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:14.688228Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:14.688253Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:14.688276Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:14.688575Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:15.692112Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:15.692179Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:15.692224Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:15.692630Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:15.692741Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:15.692769Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:15.692794Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:15.694098Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:16.696066Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:16.696129Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:16.696170Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:16.696685Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:16.696778Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:16.696800Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:16.696820Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:16.697292Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:17.699385Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:17.699448Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:17.699506Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:17.699948Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:17.700058Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:17.700101Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:17.700125Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:17.700419Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:18.701604Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:18.701670Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:18.701720Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:18.702230Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:18.702342Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:18.702369Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:18.702402Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:18.702725Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:19.703403Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:19.703452Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:19.703483Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:19.703882Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:19.703960Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:19.703977Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:19.703993Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:19.704453Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:20.706405Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:20.706482Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:20.706523Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:20.707150Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:20.707254Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:20.707281Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:20.707303Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:20.707588Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:21.709249Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:21.709309Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:21.709347Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:21.709850Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:21.709945Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:21.709967Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:21.709986Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:21.710299Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:22.711518Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:22.711581Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:22.711635Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:22.712123Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:22.712231Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:22.712256Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:22.712278Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:22.712607Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:23.714321Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:23.714387Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:23.714431Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:23.714861Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:23.714973Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:23.715001Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:23.715026Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:23.715419Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:24.716724Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:24.716791Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:24.716860Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:24.717353Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:24.717456Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:24.717481Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:24.717504Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:24.717855Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:25.719281Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:25.719341Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:25.719378Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:25.719749Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:25.719875Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:25.719914Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:25.719937Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:25.720344Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:26.722053Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:26.722106Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:26.722139Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:26.722567Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:26.722652Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:26.722672Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:26.722690Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:26.723032Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:27.724564Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:27.724623Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:27.724664Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:27.725089Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:27.725186Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:27.725266Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:27.725293Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:27.725968Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:28.727327Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:28.727395Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:28.727442Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:28.727898Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:28.728012Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:28.728040Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:28.728065Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:28.728360Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:29.730325Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:29.730392Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:29.730439Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:29.730805Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:29.730983Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:29.731011Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:29.731040Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:29.731348Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:30.733097Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:30.733159Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:30.733202Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:30.733588Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:30.733684Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:30.733706Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:30.733729Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:30.734038Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:31.736727Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:31.736789Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:31.736864Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:31.737275Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:31.737383Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:31.737410Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:31.737435Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:31.737676Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:32.738924Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:32.738988Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:32.739030Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:32.742193Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:32.742320Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:32.742346Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:32.742370Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:32.742627Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:33.744309Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:33.744374Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:33.744416Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:33.744752Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:33.744883Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:33.744910Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:33.744934Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:33.745221Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:34.747067Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:34.747128Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:34.747191Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:34.747616Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:34.747736Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:34.747764Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:34.747790Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:34.748121Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:35.750320Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:35.750379Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:35.750416Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:35.750752Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:35.750891Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:35.750923Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:35.750946Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:35.751154Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:36.752712Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:36.752778Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:36.752826Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:36.753255Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:36.753372Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:36.753401Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:36.753426Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:36.753757Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:37.754758Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:37.754823Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:37.754892Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:37.755428Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:37.755536Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:37.755562Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:37.755587Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:37.755918Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:38.756680Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:38.756731Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:38.756764Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:38.757113Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:38.757184Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:38.757201Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:38.757215Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:38.757438Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:39.759016Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:39.759064Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:39.759094Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:39.759431Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:39.759516Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:39.759534Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:39.759550Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:39.759763Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:40.760572Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:40.760624Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:40.760657Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:40.761068Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:40.761143Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:40.761160Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:40.761175Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:40.761378Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:41.763021Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:41.763080Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:41.763117Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:41.763522Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:41.763613Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("https", ic0.app) [INFO] [stdout] 2025-03-17T08:44:41.763635Z DEBUG reqwest::connect: starting new connection: https://ic0.app/ [INFO] [stdout] 2025-03-17T08:44:41.763655Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("https"), host=Some("ic0.app"), port=None [INFO] [stdout] 2025-03-17T08:44:41.763892Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("https", ic0.app) [INFO] [stdout] [INFO] [stdout] thread 'agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet' panicked at src/agent/route_provider/dynamic_routing/dynamic_route_provider.rs:345:9: [INFO] [stdout] Expected excluded domains ["ic0.app"] are still observed in routing over the last 30 calls [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5cf282321a52 - std::backtrace_rs::backtrace::libunwind::trace::hf010e1dbae51cb72 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5cf282321a52 - std::backtrace_rs::backtrace::trace_unsynchronized::hfea1b1ce70c8ef04 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5cf282321a52 - std::sys::backtrace::_print_fmt::h2997a50d2484a6a6 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5cf282321a52 - ::fmt::h7fb80f6afbe41a33 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5cf28234db03 - core::fmt::rt::Argument::fmt::hd3a68c3e7e846625 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/fmt/rt.rs:185:76 [INFO] [stdout] 5: 0x5cf28234db03 - core::fmt::write::h000527be0eea6fe8 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/fmt/mod.rs:1449:21 [INFO] [stdout] 6: 0x5cf28231d9b3 - std::io::Write::write_fmt::h5402e677befea770 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/io/mod.rs:1890:15 [INFO] [stdout] 7: 0x5cf2823218a2 - std::sys::backtrace::BacktraceLock::print::hffad87dde00cbe3e [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x5cf282322efa - std::panicking::default_hook::{{closure}}::ha46397973bec1239 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:298:22 [INFO] [stdout] 9: 0x5cf282322ce9 - std::panicking::default_hook::h706de72a1550eed4 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:322:9 [INFO] [stdout] 10: 0x5cf281706277 - as core::ops::function::Fn>::call::hde091e5c6e92bb68 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 11: 0x5cf281706277 - test::test_main::{{closure}}::h769424ff54c41197 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:136:21 [INFO] [stdout] 12: 0x5cf2823239e3 - as core::ops::function::Fn>::call::hbd7480c9dddf3315 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 13: 0x5cf2823239e3 - std::panicking::rust_panic_with_hook::h6666776865bd21f5 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:839:13 [INFO] [stdout] 14: 0x5cf28232369a - std::panicking::begin_panic_handler::{{closure}}::hb8595612365d24db [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:704:13 [INFO] [stdout] 15: 0x5cf282321f49 - std::sys::backtrace::__rust_end_short_backtrace::h7037f177c7ae4ed3 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x5cf28232332d - rust_begin_unwind [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:695:5 [INFO] [stdout] 17: 0x5cf28234b400 - core::panicking::panic_fmt::hd26142fa9828e2a3 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x5cf2814e5060 - ic_agent::agent::route_provider::dynamic_routing::dynamic_route_provider::tests::assert_no_routing_via_domains::{{closure}}::h6ff67838a43bf1de [INFO] [stdout] at /opt/rustwide/workdir/src/agent/route_provider/dynamic_routing/dynamic_route_provider.rs:345:9 [INFO] [stdout] 19: 0x5cf2814e6398 - ic_agent::agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet::{{closure}}::hdf36f0fdf0562a87 [INFO] [stdout] at /opt/rustwide/workdir/src/agent/route_provider/dynamic_routing/dynamic_route_provider.rs:375:10 [INFO] [stdout] 20: 0x5cf281559812 - as core::future::future::Future>::poll::h410d0fbfcde069a7 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/future/future.rs:124:9 [INFO] [stdout] 21: 0x5cf281559c0d - as core::future::future::Future>::poll::hdabc72286bc66c4f [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/future/future.rs:124:9 [INFO] [stdout] 22: 0x5cf28155561f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h59b9041c7e57d66b [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:733:54 [INFO] [stdout] 23: 0x5cf281555035 - tokio::task::coop::with_budget::h5948b933d3c86742 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/task/coop/mod.rs:167:5 [INFO] [stdout] 24: 0x5cf281555035 - tokio::task::coop::budget::h04df82aac1c175b0 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/task/coop/mod.rs:133:5 [INFO] [stdout] 25: 0x5cf281555035 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h51428bb0a81553e6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:733:25 [INFO] [stdout] 26: 0x5cf28154ff40 - tokio::runtime::scheduler::current_thread::Context::enter::hd869ad30d353ab1a [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:432:19 [INFO] [stdout] 27: 0x5cf2815527dc - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h523a75aeee6badff [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:732:36 [INFO] [stdout] 28: 0x5cf281552354 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::ha1e5c848df186d8e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:820:68 [INFO] [stdout] 29: 0x5cf281631e8b - tokio::runtime::context::scoped::Scoped::set::h597a9c3c06eb8b92 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 30: 0x5cf2814c9749 - tokio::runtime::context::set_scheduler::{{closure}}::h9dd167c94770b9ee [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/context.rs:180:26 [INFO] [stdout] 31: 0x5cf281531562 - std::thread::local::LocalKey::try_with::hb6636008b2ce7eab [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/local.rs:311:12 [INFO] [stdout] 32: 0x5cf28152dbfe - std::thread::local::LocalKey::with::h16b958209792b922 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/local.rs:275:15 [INFO] [stdout] 33: 0x5cf2814c95bd - tokio::runtime::context::set_scheduler::h579474fa45872ff7 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/context.rs:180:9 [INFO] [stdout] 34: 0x5cf281551370 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h1566e72c95dfbb91 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:820:27 [INFO] [stdout] 35: 0x5cf281552543 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::hcadecaecf7d8ce3e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:720:19 [INFO] [stdout] 36: 0x5cf28154a1cc - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h5f4308a413468e00 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:200:28 [INFO] [stdout] 37: 0x5cf281529538 - tokio::runtime::context::runtime::enter_runtime::h9a6075a12c697597 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 38: 0x5cf281549a21 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::hc4261d82577128bf [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/scheduler/current_thread/mod.rs:188:9 [INFO] [stdout] 39: 0x5cf281683674 - tokio::runtime::runtime::Runtime::block_on_inner::h7fe4dcf4d2c4b320 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/runtime.rs:368:47 [INFO] [stdout] 40: 0x5cf281683bb7 - tokio::runtime::runtime::Runtime::block_on::h32fab622ae767a9c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.44.1/src/runtime/runtime.rs:342:13 [INFO] [stdout] 41: 0x5cf2814e5565 - ic_agent::agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet::h10e18862a34624ec [INFO] [stdout] at /opt/rustwide/workdir/src/agent/route_provider/dynamic_routing/dynamic_route_provider.rs:381:9 [INFO] [stdout] 42: 0x5cf2814e5407 - ic_agent::agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet::{{closure}}::hc774e27cc488ce10 [INFO] [stdout] at /opt/rustwide/workdir/src/agent/route_provider/dynamic_routing/dynamic_route_provider.rs:349:28 [INFO] [stdout] 43: 0x5cf28150fc26 - core::ops::function::FnOnce::call_once::hc75ac06b4f5e8f3b [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 44: 0x5cf28170bb7b - core::ops::function::FnOnce::call_once::h537cb3ba0681a85d [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5cf28170bb7b - test::__rust_begin_short_backtrace::ha34590b284b8a909 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:638:18 [INFO] [stdout] 46: 0x5cf28170ac15 - test::run_test_in_process::{{closure}}::h7e5cb0195a5ea6a6 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:661:60 [INFO] [stdout] 47: 0x5cf28170ac15 - as core::ops::function::FnOnce<()>>::call_once::h4fd7826f39023efe [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 48: 0x5cf28170ac15 - std::panicking::try::do_call::h840562177f324507 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:587:40 [INFO] [stdout] 49: 0x5cf28170ac15 - std::panicking::try::h2360ed2f8f8e7bd8 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:550:19 [INFO] [stdout] 50: 0x5cf28170ac15 - std::panic::catch_unwind::h98cd8da2f8eb8f7b [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panic.rs:359:14 [INFO] [stdout] 51: 0x5cf28170ac15 - test::run_test_in_process::hcd6b1143eaf140ef [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:661:27 [INFO] [stdout] 52: 0x5cf28170ac15 - test::run_test::{{closure}}::h12da0337272887dc [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:582:43 [INFO] [stdout] 53: 0x5cf2816cdc04 - test::run_test::{{closure}}::h11d537cad5364bdc [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:612:41 [INFO] [stdout] 54: 0x5cf2816cdc04 - std::sys::backtrace::__rust_begin_short_backtrace::h5f533949825eb644 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 55: 0x5cf2816d166a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf8cffede9b676267 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 56: 0x5cf2816d166a - as core::ops::function::FnOnce<()>>::call_once::h3160424131f9b05b [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 57: 0x5cf2816d166a - std::panicking::try::do_call::h4821f856f783960c [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:587:40 [INFO] [stdout] 58: 0x5cf2816d166a - std::panicking::try::hd6726363e8162e27 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:550:19 [INFO] [stdout] 59: 0x5cf2816d166a - std::panic::catch_unwind::hb75a27d7bd2912cb [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panic.rs:359:14 [INFO] [stdout] 60: 0x5cf2816d166a - std::thread::Builder::spawn_unchecked_::{{closure}}::h36d5666a81748b85 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 61: 0x5cf2816d166a - core::ops::function::FnOnce::call_once{{vtable.shim}}::ha3d6556f1deabcaf [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 62: 0x5cf28232723b - as core::ops::function::FnOnce>::call_once::h454485597884df01 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 63: 0x5cf28232723b - as core::ops::function::FnOnce>::call_once::h421b8b5dc09cf3b4 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 64: 0x5cf28232723b - std::sys::pal::unix::thread::Thread::new::thread_start::ha1530b93ff336c49 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/pal/unix/thread.rs:109:17 [INFO] [stdout] 65: 0x7f4c57cd3ac3 - [INFO] [stdout] 66: 0x7f4c57d64a04 - clone [INFO] [stdout] 67: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] agent::route_provider::dynamic_routing::dynamic_route_provider::tests::test_mainnet [INFO] [stdout] [INFO] [stdout] test result: FAILED. 54 passed; 1 failed; 1 ignored; 0 measured; 0 filtered out; finished in 41.11s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "c79dad4c7b884c7262a525938e666d85e66a8ebb9dfbfa3094998685b0864824", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c79dad4c7b884c7262a525938e666d85e66a8ebb9dfbfa3094998685b0864824", kill_on_drop: false }` [INFO] [stdout] c79dad4c7b884c7262a525938e666d85e66a8ebb9dfbfa3094998685b0864824