[INFO] fetching crate radicle-node 0.10.0... [INFO] testing radicle-node-0.10.0 against beta-2025-04-13 for beta-1.87-1 [INFO] extracting crate radicle-node 0.10.0 into /workspace/builds/worker-1-tc2/source [INFO] validating manifest of crates.io crate radicle-node 0.10.0 on toolchain beta-2025-04-13 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-04-13" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate radicle-node 0.10.0 [INFO] finished tweaking crates.io crate radicle-node 0.10.0 [INFO] tweaked toml for crates.io crate radicle-node 0.10.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml [INFO] crate crates.io crate radicle-node 0.10.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-04-13" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 8c8db2ea7f9b6dbeb14910ee6869548a87d079a0adc6307f2a63b9d3cf8e60fe [INFO] running `Command { std: "docker" "start" "-a" "8c8db2ea7f9b6dbeb14910ee6869548a87d079a0adc6307f2a63b9d3cf8e60fe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "8c8db2ea7f9b6dbeb14910ee6869548a87d079a0adc6307f2a63b9d3cf8e60fe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8c8db2ea7f9b6dbeb14910ee6869548a87d079a0adc6307f2a63b9d3cf8e60fe", kill_on_drop: false }` [INFO] [stdout] 8c8db2ea7f9b6dbeb14910ee6869548a87d079a0adc6307f2a63b9d3cf8e60fe [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0fc8e22f64bce2b56bf8be482e21be252b34484c23576b032937501c82e71442 [INFO] running `Command { std: "docker" "start" "-a" "0fc8e22f64bce2b56bf8be482e21be252b34484c23576b032937501c82e71442", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.155 [INFO] [stderr] Compiling proc-macro2 v1.0.81 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling thiserror v1.0.59 [INFO] [stderr] Compiling memchr v2.7.2 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling regex-automata v0.4.6 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling subtle v2.5.0 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling cpufeatures v0.2.12 [INFO] [stderr] Compiling fastrand v2.1.0 [INFO] [stderr] Compiling zeroize v1.7.0 [INFO] [stderr] Compiling gix-trace v0.1.9 [INFO] [stderr] Compiling autocfg v1.2.0 [INFO] [stderr] Compiling bitflags v2.5.0 [INFO] [stderr] Compiling crc32fast v1.4.0 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling faster-hex v0.9.0 [INFO] [stderr] Compiling bstr v1.9.1 [INFO] [stderr] Compiling unicode-normalization v0.1.23 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling syn v2.0.60 [INFO] [stderr] Compiling getrandom v0.2.14 [INFO] [stderr] Compiling jobserver v0.1.31 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling pkg-config v0.3.30 [INFO] [stderr] Compiling cc v1.0.95 [INFO] [stderr] Compiling gix-utils v0.1.12 [INFO] [stderr] Compiling miniz_oxide v0.7.2 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling sha1_smol v1.0.0 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling block-padding v0.3.3 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling inout v0.1.3 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling cipher v0.4.4 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling flate2 v1.0.28 [INFO] [stderr] Compiling prodash v28.0.0 [INFO] [stderr] Compiling universal-hash v0.5.1 [INFO] [stderr] Compiling opaque-debug v0.3.1 [INFO] [stderr] Compiling itoa v1.0.11 [INFO] [stderr] Compiling smallvec v1.13.2 [INFO] [stderr] Compiling lock_api v0.4.11 [INFO] [stderr] Compiling parking_lot_core v0.9.9 [INFO] [stderr] Compiling data-encoding v2.5.0 [INFO] [stderr] Compiling time-core v0.1.2 [INFO] [stderr] Compiling amplify_num v0.5.2 [INFO] [stderr] Compiling signature v1.6.4 [INFO] [stderr] Compiling amplify_syn v2.0.1 [INFO] [stderr] Compiling unicode-bidi v0.3.15 [INFO] [stderr] Compiling ascii v1.1.0 [INFO] [stderr] Compiling serde v1.0.198 [INFO] [stderr] Compiling idna v0.5.0 [INFO] [stderr] Compiling time-macros v0.2.18 [INFO] [stderr] Compiling ed25519 v1.5.3 [INFO] [stderr] Compiling amplify_derive v4.0.0 [INFO] [stderr] Compiling data-encoding-macro-internal v0.1.12 [INFO] [stderr] Compiling deranged v0.3.11 [INFO] [stderr] Compiling aead v0.5.2 [INFO] [stderr] Compiling data-encoding-macro v0.1.14 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling base-x v0.2.11 [INFO] [stderr] Compiling num_threads v0.1.7 [INFO] [stderr] Compiling ct-codecs v1.1.1 [INFO] [stderr] Compiling home v0.5.9 [INFO] [stderr] Compiling rustix v0.38.34 [INFO] [stderr] Compiling ec25519 v0.1.0 [INFO] [stderr] Compiling multibase v0.9.1 [INFO] [stderr] Compiling url v2.5.0 [INFO] [stderr] Compiling libz-sys v1.1.16 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling time v0.3.36 [INFO] [stderr] Compiling poly1305 v0.8.0 [INFO] [stderr] Compiling chacha20 v0.9.1 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling hashbrown v0.14.3 [INFO] [stderr] Compiling linux-raw-sys v0.4.13 [INFO] [stderr] Compiling winnow v0.6.8 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling keccak v0.1.5 [INFO] [stderr] Compiling sha3 v0.10.8 [INFO] [stderr] Compiling amplify v4.6.0 [INFO] [stderr] Compiling sqlite3-src v0.5.1 [INFO] [stderr] Compiling thiserror-impl v1.0.59 [INFO] [stderr] Compiling serde_derive v1.0.198 [INFO] [stderr] Compiling cyphergraphy v0.3.0 [INFO] [stderr] Compiling libgit2-sys v0.17.0+1.8.1 [INFO] [stderr] Compiling polyval v0.6.2 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling base64ct v1.6.0 [INFO] [stderr] Compiling base32 v0.4.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.19 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling cypheraddr v0.4.0 [INFO] [stderr] Compiling pem-rfc7468 v0.7.0 [INFO] [stderr] Compiling pbkdf2 v0.12.2 [INFO] [stderr] Compiling ghash v0.5.1 [INFO] [stderr] Compiling gix-hash v0.14.2 [INFO] [stderr] Compiling gix-path v0.10.9 [INFO] [stderr] Compiling gix-date v0.8.7 [INFO] [stderr] Compiling git-ref-format-core v0.3.0 [INFO] [stderr] Compiling gix-features v0.38.2 [INFO] [stderr] Compiling gix-actor v0.31.5 [INFO] [stderr] Compiling gix-validate v0.8.5 [INFO] [stderr] Compiling chacha20poly1305 v0.10.1 [INFO] [stderr] Compiling aes v0.8.4 [INFO] [stderr] Compiling ctr v0.9.2 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling gix-object v0.42.3 [INFO] [stderr] Compiling noise-framework v0.4.0 [INFO] [stderr] Compiling git-ref-format-macro v0.3.0 [INFO] [stderr] Compiling gix-chunk v0.4.8 [INFO] [stderr] Compiling aes-gcm v0.10.3 [INFO] [stderr] Compiling ssh-encoding v0.2.0 [INFO] [stderr] Compiling socks5-client v0.4.1 [INFO] [stderr] Compiling blowfish v0.9.1 [INFO] [stderr] Compiling cbc v0.1.2 [INFO] [stderr] Compiling memmap2 v0.9.4 [INFO] [stderr] Compiling shell-words v1.1.0 [INFO] [stderr] Compiling ssh-cipher v0.2.0 [INFO] [stderr] Compiling gix-command v0.3.6 [INFO] [stderr] Compiling gix-commitgraph v0.24.3 [INFO] [stderr] Compiling crossbeam-channel v0.5.13 [INFO] [stderr] Compiling cyphernet v0.5.2 [INFO] [stderr] Compiling bcrypt-pbkdf v0.10.0 [INFO] [stderr] Compiling tempfile v3.10.1 [INFO] [stderr] Compiling gix-hashtable v0.5.2 [INFO] [stderr] Compiling num-traits v0.2.18 [INFO] [stderr] Compiling radicle-std-ext v0.1.0 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling serde_json v1.0.116 [INFO] [stderr] Compiling signature v2.2.0 [INFO] [stderr] Compiling ssh-key v0.6.6 [INFO] [stderr] Compiling indexmap v2.2.6 [INFO] [stderr] Compiling gix-revwalk v0.13.2 [INFO] [stderr] Compiling radicle-ssh v0.9.0 [INFO] [stderr] Compiling gix-fs v0.11.2 [INFO] [stderr] Compiling gix-url v0.27.3 [INFO] [stderr] Compiling gix-config-value v0.14.6 [INFO] [stderr] Compiling gix-quote v0.4.12 [INFO] [stderr] Compiling gix-sec v0.10.6 [INFO] [stderr] Compiling ryu v1.0.17 [INFO] [stderr] Compiling gix-prompt v0.8.4 [INFO] [stderr] Compiling gix-tempfile v14.0.1 [INFO] [stderr] Compiling gix-traverse v0.39.2 [INFO] [stderr] Compiling gix-diff v0.44.1 [INFO] [stderr] Compiling gix-packetline v0.17.5 [INFO] [stderr] Compiling radicle-dag v0.9.0 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling colored v2.1.0 [INFO] [stderr] Compiling gix-transport v0.42.0 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling gix-pack v0.51.1 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling gix-credentials v0.24.2 [INFO] [stderr] Compiling maybe-async v0.2.10 [INFO] [stderr] Compiling popol v3.0.0 [INFO] [stderr] Compiling base64 v0.21.7 [INFO] [stderr] Compiling anyhow v1.0.82 [INFO] [stderr] Compiling siphasher v1.0.1 [INFO] [stderr] Compiling arc-swap v1.7.1 [INFO] [stderr] Compiling gix-protocol v0.45.0 [INFO] [stderr] Compiling nonempty v0.9.0 [INFO] [stderr] Compiling localtime v1.3.1 [INFO] [stderr] Compiling git-ref-format v0.3.0 [INFO] [stderr] Compiling gix-odb v0.61.1 [INFO] [stderr] Compiling io-reactor v0.5.2 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling salsa20 v0.10.2 [INFO] [stderr] Compiling socket2 v0.5.7 [INFO] [stderr] Compiling siphasher v0.3.11 [INFO] [stderr] Compiling radicle-node v0.10.0 (/opt/rustwide/workdir) [INFO] [stderr] Compiling either v1.11.0 [INFO] [stderr] Compiling netservices v0.8.0 [INFO] [stderr] Compiling bloomy v1.2.0 [INFO] [stderr] Compiling scrypt v0.11.0 [INFO] [stderr] Compiling radicle-signals v0.10.0 [INFO] [stderr] Compiling radicle-systemd v0.9.0 [INFO] [stderr] Compiling lexopt v0.3.0 [INFO] [stderr] Compiling git2 v0.19.0 [INFO] [stderr] Compiling radicle-git-ext v0.8.0 [INFO] [stderr] Compiling sqlite3-sys v0.15.2 [INFO] [stderr] Compiling sqlite v0.32.0 [INFO] [stderr] Compiling radicle-crypto v0.11.0 [INFO] [stderr] Compiling radicle-cob v0.12.0 [INFO] [stderr] Compiling radicle v0.13.0 [INFO] [stderr] Compiling radicle-fetch v0.10.0 [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 3m 18s [INFO] running `Command { std: "docker" "inspect" "0fc8e22f64bce2b56bf8be482e21be252b34484c23576b032937501c82e71442", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0fc8e22f64bce2b56bf8be482e21be252b34484c23576b032937501c82e71442", kill_on_drop: false }` [INFO] [stdout] 0fc8e22f64bce2b56bf8be482e21be252b34484c23576b032937501c82e71442 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] dabc4f6c6acb5ef654ef5fa9dec53341e91cc97b1c7f53b793ebeb5fb8a57177 [INFO] running `Command { std: "docker" "start" "-a" "dabc4f6c6acb5ef654ef5fa9dec53341e91cc97b1c7f53b793ebeb5fb8a57177", kill_on_drop: false }` [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling utf8parse v0.2.1 [INFO] [stderr] Compiling anstyle-query v1.0.2 [INFO] [stderr] Compiling anstyle v1.0.6 [INFO] [stderr] Compiling colorchoice v1.0.0 [INFO] [stderr] Compiling similar v2.5.0 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling anstyle-parse v0.2.3 [INFO] [stderr] Compiling anstream v0.6.13 [INFO] [stderr] Compiling snapbox-macros v0.3.8 [INFO] [stderr] Compiling snapbox v0.4.17 [INFO] [stderr] Compiling qcheck v1.0.0 [INFO] [stderr] Compiling amplify_syn v2.0.1 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling data-encoding-macro-internal v0.1.12 [INFO] [stderr] Compiling git-ref-format-macro v0.3.0 [INFO] [stderr] Compiling qcheck-macros v1.0.0 [INFO] [stderr] Compiling amplify_derive v4.0.0 [INFO] [stderr] Compiling git-ref-format v0.3.0 [INFO] [stderr] Compiling radicle-git-ext v0.8.0 [INFO] [stderr] Compiling data-encoding-macro v0.1.14 [INFO] [stderr] Compiling multibase v0.9.1 [INFO] [stderr] Compiling amplify v4.6.0 [INFO] [stderr] Compiling cyphergraphy v0.3.0 [INFO] [stderr] Compiling io-reactor v0.5.2 [INFO] [stderr] Compiling cypheraddr v0.4.0 [INFO] [stderr] Compiling noise-framework v0.4.0 [INFO] [stderr] Compiling socks5-client v0.4.1 [INFO] [stderr] Compiling cyphernet v0.5.2 [INFO] [stderr] Compiling radicle-crypto v0.11.0 [INFO] [stderr] Compiling netservices v0.8.0 [INFO] [stderr] Compiling radicle-cob v0.12.0 [INFO] [stderr] Compiling radicle v0.13.0 [INFO] [stderr] Compiling radicle-fetch v0.10.0 [INFO] [stderr] Compiling radicle-node v0.10.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 22s [INFO] running `Command { std: "docker" "inspect" "dabc4f6c6acb5ef654ef5fa9dec53341e91cc97b1c7f53b793ebeb5fb8a57177", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dabc4f6c6acb5ef654ef5fa9dec53341e91cc97b1c7f53b793ebeb5fb8a57177", kill_on_drop: false }` [INFO] [stdout] dabc4f6c6acb5ef654ef5fa9dec53341e91cc97b1c7f53b793ebeb5fb8a57177 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:b0b074c097205a61b89e8ad263052f976b2b332c4dc5f02aef1fe52501660d6e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-04-13" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 74a06bed1c3558bdbd806f8434239c165e4afdef90aa2df779387d44470cbc9c [INFO] running `Command { std: "docker" "start" "-a" "74a06bed1c3558bdbd806f8434239c165e4afdef90aa2df779387d44470cbc9c", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.91s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/radicle_node-0010c1327a42dab0) [INFO] [stdout] [INFO] [stdout] running 110 tests [INFO] [stdout] test deserializer::test::test_decode_next ... ok [INFO] [stdout] test service::filter::test::test_parameters ... ok [INFO] [stdout] test deserializer::test::prop_decode_next ... ok [INFO] [stdout] test service::limiter::test::test_limitter_different_rates ... ok [INFO] [stdout] test service::limiter::test::test_limitter_refill ... ok [INFO] [stdout] test control::tests::test_control_socket ... ok [INFO] [stdout] test deserializer::test::test_unparsed ... ok [INFO] [stdout] test service::limiter::test::test_limitter_multi ... ok [INFO] [stdout] test control::tests::test_seed_unseed ... ok [INFO] [stdout] test service::gossip::store::test::test_announced ... ok [INFO] [stdout] test service::message::tests::test_ref_remote_limit ... ok [INFO] [stdout] test service::filter::test::test_sizes ... ok [INFO] [stdout] test service::message::tests::test_inventory_limit ... ok [INFO] [stdout] test service::message::tests::prop_refs_announcement_signing ... ok [INFO] [stdout] test tests::e2e::test_connection_crossing ... ok [INFO] [stdout] test tests::e2e::missing_default_branch ... ok [INFO] [stdout] test tests::e2e::test_clone ... ok [INFO] [stdout] test tests::e2e::test_dont_fetch_owned_refs ... ok [INFO] [stdout] test tests::e2e::test_fetch_followed_remotes ... ok [INFO] [stdout] test tests::e2e::test_catchup_on_refs_announcements ... ok [INFO] [stdout] test tests::e2e::test_background_foreground_fetch ... ok [INFO] [stdout] test tests::e2e::test_fetch_preserve_owned_refs ... ok [INFO] [stdout] test tests::e2e::test_fetch_unseeded ... ok [INFO] [stdout] test tests::e2e::test_fetch_up_to_date ... ok [INFO] [stdout] test tests::e2e::test_inventory_sync_basic ... ok [INFO] [stdout] test service::message::tests::test_node_announcement_validate ... ok [INFO] [stdout] test tests::e2e::test_migrated_clone ... ok [INFO] [stdout] test tests::e2e::test_missing_remote ... ok [INFO] [stdout] test tests::e2e::test_multiple_offline_inits ... ok [INFO] [stdout] test tests::e2e::test_inventory_sync_bridge ... ok [INFO] [stdout] test tests::e2e::test_inventory_sync_ring ... ok [INFO] [stdout] test tests::e2e::test_non_fastforward_sigrefs ... ok [INFO] [stdout] test tests::e2e::test_inventory_sync_star ... ok [INFO] [stdout] test tests::e2e::test_replication ... ok [INFO] [stdout] test tests::e2e::test_replication_invalid ... ok [INFO] [stdout] test tests::e2e::test_concurrent_fetches ... ok [INFO] [stdout] test tests::e2e::test_outdated_delegate_sigrefs ... ok [INFO] [stdout] test tests::e2e::test_replication_ref_in_sigrefs ... ok [INFO] [stdout] test tests::e2e::test_outdated_sigrefs ... ok [INFO] [stdout] test tests::test_announcement_rebroadcast_duplicates ... ok [INFO] [stdout] test tests::test_announcement_rebroadcast ... ok [INFO] [stdout] test tests::test_connection_kept_alive ... ok [INFO] [stdout] test tests::test_announcement_relay ... ok [INFO] [stdout] test tests::test_announcement_rebroadcast_timestamp_filtered ... ok [INFO] [stdout] test tests::test_disconnecting_unresponsive_peer ... ok [INFO] [stdout] test tests::test_fetch_missing_inventory_on_gossip ... ok [INFO] [stdout] test tests::test_inventory_decode ... ok [INFO] [stdout] test tests::test_fetch_missing_inventory_on_schedule ... ok [INFO] [stdout] test tests::test_inbound_connection ... ok [INFO] [stdout] test tests::e2e::test_large_fetch ... FAILED [INFO] [stdout] test tests::test_inventory_relay_bad_timestamp ... ok [INFO] [stdout] test tests::test_inventory_relay ... ok [INFO] [stdout] test tests::test_maintain_connections_failed_attempt ... ok [INFO] [stdout] test tests::test_inventory_sync ... ok [INFO] [stdout] test tests::test_outbound_connection ... ok [INFO] [stdout] test tests::test_maintain_connections_transient ... ok [INFO] [stdout] test tests::test_init_and_seed ... ok [INFO] [stdout] test tests::test_persistent_peer_connect ... ok [INFO] [stdout] test tests::test_persistent_peer_reconnect_success ... ok [INFO] [stdout] test tests::test_maintain_connections ... ok [INFO] [stdout] test tests::test_persistent_peer_reconnect_attempt ... ok [INFO] [stdout] test tests::test_ping_response ... ok [INFO] [stdout] test tests::test_queued_fetch_max_capacity ... ok [INFO] [stdout] test tests::test_redundant_connect ... ok [INFO] [stdout] test tests::test_queued_fetch_from_command_same_rid ... ok [INFO] [stdout] test tests::test_queued_fetch_from_ann_same_rid ... ok [INFO] [stdout] test tests::test_refs_announcement_followed ... ok [INFO] [stdout] test tests::test_refs_announcement_no_subscribe ... ok [INFO] [stdout] test tests::test_refs_announcement_fetch_trusted_no_inventory ... ok [INFO] [stdout] test tests::test_seed_repo_subscribe ... ok [INFO] [stdout] test wire::frame::test::test_stream_id ... ok [INFO] [stdout] test wire::message::tests::prop_addr ... ok [INFO] [stdout] test tests::test_seeding ... ok [INFO] [stdout] test tests::test_refs_synced_event ... ok [INFO] [stdout] test tests::test_refs_announcement_offline ... ok [INFO] [stdout] test wire::message::tests::test_inv_ann_max_size ... ok [INFO] [stdout] test wire::message::tests::test_node_ann_max_size ... ok [INFO] [stdout] test wire::message::tests::test_pingpong_encode_max_size ... ok [INFO] [stdout] test wire::message::tests::test_pingpong_encode_size_overflow ... ok [INFO] [stdout] test tests::test_refs_announcement_relay ... ok [INFO] [stdout] test wire::protocol::test::test_inventory_ann_with_extension ... ok [INFO] [stdout] test wire::protocol::test::test_pong_message_with_extension ... ok [INFO] [stdout] test wire::message::tests::prop_message_encode_decode ... ok [INFO] [stdout] test wire::tests::prop_id ... ok [INFO] [stdout] test wire::tests::prop_oid ... ok [INFO] [stdout] test wire::tests::prop_filter ... ok [INFO] [stdout] test wire::tests::prop_refs ... ok [INFO] [stdout] test wire::tests::prop_signature ... ok [INFO] [stdout] test wire::tests::prop_signed_refs ... ok [INFO] [stdout] test wire::tests::prop_string ... ok [INFO] [stdout] test wire::tests::prop_tuple ... ok [INFO] [stdout] test wire::tests::prop_u16 ... ok [INFO] [stdout] test wire::tests::prop_u32 ... ok [INFO] [stdout] test wire::tests::prop_u64 ... ok [INFO] [stdout] test wire::tests::prop_u8 ... ok [INFO] [stdout] test wire::tests::prop_pubkey ... ok [INFO] [stdout] test wire::tests::test_alias ... ok [INFO] [stdout] test wire::tests::test_bounded_vec_limit ... ok [INFO] [stdout] test wire::tests::test_filter_invalid ... ok [INFO] [stdout] test wire::tests::test_string ... ok [INFO] [stdout] test wire::varint::test::prop_encode_decode ... ok [INFO] [stdout] test wire::varint::test::test_encode_overflow - should panic ... ok [INFO] [stdout] test wire::varint::test::test_encoding ... ok [INFO] [stdout] test wire::tests::prop_vec ... ok [INFO] [stdout] test wire::message::tests::test_refs_ann_max_size ... ok [INFO] [stdout] test wire::message::tests::prop_zero_bytes_encode_decode ... ok [INFO] [stdout] test tests::test_inventory_pruning ... ok [INFO] [stdout] test wire::message::tests::prop_message_decoder ... ok [INFO] [stdout] test tests::prop_inventory_exchange_dense ... ok [INFO] [stdout] test tests::test_announcement_message_amplification ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::e2e::test_large_fetch stdout ---- [INFO] [stdout] 1744766838 test: Node::init alice: z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766839 test: Node::init bob: z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 [INFO] [stdout] 1744766841 tests::e2e::test_large_fetch cob: Loading object of type xyz.radicle.id at f41181b6e62227277d39429c7a52e8df0b782051 [INFO] [stdout] 1744766841 tests::e2e::test_large_fetch storage: Setting ref: refs/rad/id -> f41181b6e62227277d39429c7a52e8df0b782051 [INFO] [stdout] 1744766841 tests::e2e::test_large_fetch storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 [INFO] [stdout] 1744766841 tests::e2e::test_large_fetch storage: Setting ref: HEAD -> refs/heads/master [INFO] [stdout] 1744766841 test: Initialized project rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN for node z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766851 tests::e2e::test_large_fetch node: Opening policy database.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Default seeding policy set to 'block (all)' [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Initializing service (Test).. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Opening node database.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Address book is empty. Adding bootstrap nodes.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: 0 nodes added to address book [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Init @1744766851891 [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Empty refs database, populating from storage.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Saved local sync status for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Adding refs announcement for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN to historical gossip messages.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Not enough available peers to connect to (available=0, wanted=8) [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b node: Listening on 0.0.0.0:44311.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Binding control socket /tmp/.tmp3YKa5R/misc/Qn1FubKK/node/control.sock.. [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b node: Running node z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b in /tmp/.tmp3YKa5R/misc/Qn1FubKK.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Opening policy database.. [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b control: Control thread listening on socket.. [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b node: Signal notifications channel error: receiving on an empty and disconnected channel [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received command QueryState(..) [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Default seeding policy set to 'block (all)' [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Initializing service (Test).. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Opening node database.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Address book is empty. Adding bootstrap nodes.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: 0 nodes added to address book [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Init @1744766852490 [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Empty refs database, populating from storage.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch service: Not enough available peers to connect to (available=0, wanted=8) [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 node: Listening on 0.0.0.0:46657.. [INFO] [stdout] 1744766852 tests::e2e::test_large_fetch node: Binding control socket /tmp/.tmp3YKa5R/misc/lKCIvbIW/node/control.sock.. [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received command Seed(rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN, all) [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 node: Running node z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 in /tmp/.tmp3YKa5R/misc/lKCIvbIW.. [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 control: Control thread listening on socket.. [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 node: Signal notifications channel error: receiving on an empty and disconnected channel [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received command QueryState(..) [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received command QueryState(..) [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received command Connect(z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2, 0.0.0.0:46657, ConnectOptions { persistent: false, timeout: 30s }) [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Connecting to z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (0.0.0.0:46657).. [INFO] [stdout] 1744766852 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Attempted connection to z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (0.0.0.0:46657) [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Inbound connection from 127.0.0.1:43610 (fd=300).. [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Accepted inbound connection from 127.0.0.1:43610 (fd=300).. [INFO] [stdout] 1744766852 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Inbound peer resource registered with id=2 (fd=300) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Registering outbound transport for z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (fd=299).. [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Outbound peer resource registered for z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 with id=2 (fd=299) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Session established with z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (id=2) (fd=299) (outbound) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Connected to z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (0.0.0.0:46657) (Outbound) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Subscribing to messages since timestamp 1744680453056.. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Session established with z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (id=2) (fd=300) (inbound) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Connected to z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (127.0.0.1:43610) (Inbound) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Subscribing to messages since timestamp 1744680453060.. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received node announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b with 0 address(es) from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766851891) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received node announcement of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 with 0 address(es) from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766852490) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Stored announcement from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b to be broadcast in 0 millisecond(s) (t=1744766851891) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Stored announcement from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 to be broadcast in 0 millisecond(s) (t=1744766852490) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Address store entry for node z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b updated at 1744766851891 [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received inventory announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b with 1 item(s) from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766851893) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Address store entry for node z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 updated at 1744766852490 [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received inventory announcement of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 with 0 item(s) from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766852491) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Stored announcement from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b to be broadcast in 0 millisecond(s) (t=1744766851893) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Stored announcement from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 to be broadcast in 0 millisecond(s) (t=1744766852491) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received subscription filter from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Sending refs announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with 1 remote(s) to z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766851892) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Routing table updated for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with seed z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Missing seeded inventory rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN; initiating fetch.. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Fetch initiated for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [inbound connected] (all remotes).. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received subscription filter from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Opened new stream with id 13 for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN and remote z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 worker: Worker processing outgoing fetch for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received refs announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with 1 remote(s) from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766851892) [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Received `open` command for stream 13 from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Worker processing incoming fetch for z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 on stream 13.. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Stored announcement from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b to be broadcast in 0 millisecond(s) (t=1744766851892) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Queueing fetch for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (already fetching).. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 worker: z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 cloning from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766853 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Spawning upload-pack process for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN on stream 13.. [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Fetched rad/id (85ms) [INFO] [stdout] 1744766853 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Fetched data for 1 remote(s) (159ms) [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Read channel timed out for upload-pack rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Upload pack finished (3381ms) [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Upload process on stream 13 exited with result Ok(()) [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Received fetch result from worker for stream 13, remote z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2: Responder { rid: Some(RepoId(rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN)), result: Ok(()) } [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Stream 13 of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 closing with 0 byte(s) sent and 0 byte(s) received [INFO] [stdout] 1744766856 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Peer z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetched rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from us successfully [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Received `close` command for stream 13 from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Stream 13 of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b closed with 0 byte(s) sent and 0 byte(s) received [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Clone of rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b failed with 'Could not access repository or failed to read streaming pack file' (4766ms) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Received fetch result from worker for stream 13, remote z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b: Initiator { rid: RepoId(rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN), result: Err(Fetch(Run(Protocol(Step(Io(Custom { kind: Other, error: Io(Custom { kind: Other, error: Write(IndexWrite(PackEntryDecode(Io(Kind(ConnectionReset))))) }) })))))) } [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Fetch failed for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b: Could not access repository or failed to read streaming pack file [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Dequeued fetch for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from session z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b.. [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Fetch initiated for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [inbound connected] (1 remote(s)).. [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 wire: Opened new stream with id 21 for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN and remote z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 worker: Worker processing outgoing fetch for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Received `open` command for stream 21 from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Worker processing incoming fetch for z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 on stream 21.. [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 worker: z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 cloning from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Spawning upload-pack process for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN on stream 21.. [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Not enough available peers to connect to (available=0, wanted=7) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Fetched rad/id (150ms) [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Sending inventory announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b with 1 item(s) to z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766851893) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Received inventory announcement of z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b with 1 item(s) from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766851893) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Ignoring stale announcement from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766851893) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Fetched data for 1 remote(s) (332ms) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Not enough available peers to connect to (available=0, wanted=8) [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Queueing fetch for rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN with z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (already fetching).. [INFO] [stdout] 1744766858 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 service: Sending inventory announcement of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 with 0 item(s) to z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b (t=1744766852491) [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Received inventory announcement of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 with 0 item(s) from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766852491) [INFO] [stdout] 1744766858 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Ignoring stale announcement from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (t=1744766852491) [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Read channel timed out for upload-pack rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Upload pack finished (3415ms) [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b worker: Upload process on stream 21 exited with result Ok(()) [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Received fetch result from worker for stream 21, remote z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2: Responder { rid: Some(RepoId(rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN)), result: Ok(()) } [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Stream 21 of z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 closing with 0 byte(s) sent and 0 byte(s) received [INFO] [stdout] 1744766861 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Peer z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetched rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from us successfully [INFO] [stdout] [INFO] [stdout] thread 'tests::e2e::test_large_fetch' panicked at src/tests/e2e.rs:686:10: [INFO] [stdout] called `Result::unwrap()` on an `Err` value: Timeout [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5c9aa1997ad2 - std::backtrace_rs::backtrace::libunwind::trace::h97da83aab53f337d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5c9aa1997ad2 - std::backtrace_rs::backtrace::trace_unsynchronized::h07d9fad959b0b0c4 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5c9aa1997ad2 - std::sys::backtrace::_print_fmt::h73b6844d523a91e6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5c9aa1997ad2 - ::fmt::had50d3dbab4f9a49 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5c9aa19c3d63 - core::fmt::rt::Argument::fmt::h96dc2668ac588484 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/rt.rs:184:76 [INFO] [stdout] 5: 0x5c9aa19c3d63 - core::fmt::write::h3c068850dd3fcd11 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/fmt/mod.rs:1480:21 [INFO] [stdout] 6: 0x5c9aa1993623 - std::io::default_write_fmt::h9f5cac5e26eafb82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5c9aa1993623 - std::io::Write::write_fmt::h9be88ac981c80255 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x5c9aa1997922 - std::sys::backtrace::BacktraceLock::print::h160d33c700b1accf [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x5c9aa1998ebc - std::panicking::default_hook::{{closure}}::hdccf862335980e92 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x5c9aa1998d12 - std::panicking::default_hook::h92ea296b4f4c5d78 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x5c9aa1054a34 - as core::ops::function::Fn>::call::h58e2cb0c3aa8f900 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x5c9aa1054a34 - test::test_main::{{closure}}::h068e739b3ff3ace9 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:136:21 [INFO] [stdout] 13: 0x5c9aa1999933 - as core::ops::function::Fn>::call::h4dc3b8e0d98a0945 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x5c9aa1999933 - std::panicking::rust_panic_with_hook::h53eb519a340d7090 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x5c9aa199960a - std::panicking::begin_panic_handler::{{closure}}::h1b012222d781940d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:706:13 [INFO] [stdout] 16: 0x5c9aa1997fc9 - std::sys::backtrace::__rust_end_short_backtrace::hb1c00a6a74936045 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x5c9aa199929d - __rustc[3fad54a3e94379e3]::rust_begin_unwind [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x5c9aa0a1d120 - core::panicking::panic_fmt::h5646b0c12be1dead [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x5c9aa0a1d5b6 - core::result::unwrap_failed::hc06d646aff6e2a9a [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/result.rs:1704:5 [INFO] [stdout] 20: 0x5c9aa0ece19c - core::result::Result::unwrap::hd24f0a3ef5cf0d63 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/result.rs:1109:23 [INFO] [stdout] 21: 0x5c9aa0ece19c - radicle_node::tests::e2e::test_large_fetch::hf878591d6e5ca8a2 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/e2e.rs:678:5 [INFO] [stdout] 22: 0x5c9aa0ecd8b7 - radicle_node::tests::e2e::test_large_fetch::{{closure}}::ha112a6e04b7f3c62 [INFO] [stdout] at /opt/rustwide/workdir/src/tests/e2e.rs:657:22 [INFO] [stdout] 23: 0x5c9aa0b04216 - core::ops::function::FnOnce::call_once::hdcbf298aaaaa6237 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x5c9aa105a38b - core::ops::function::FnOnce::call_once::h36fc4a9de3ab6dc6 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x5c9aa105a38b - test::__rust_begin_short_backtrace::ha0a98bb69b358a31 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:638:18 [INFO] [stdout] 26: 0x5c9aa105937f - test::run_test_in_process::{{closure}}::h8c178d13fba0a588 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:60 [INFO] [stdout] 27: 0x5c9aa105937f - as core::ops::function::FnOnce<()>>::call_once::hcf9a13e44c998160 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 28: 0x5c9aa105937f - std::panicking::try::do_call::h4af5be696220e430 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 29: 0x5c9aa105937f - std::panicking::try::hbf49a526ff439d5e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 30: 0x5c9aa105937f - std::panic::catch_unwind::h73db1b343ad1c705 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x5c9aa105937f - test::run_test_in_process::hef059ed743ea6437 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:661:27 [INFO] [stdout] 32: 0x5c9aa105937f - test::run_test::{{closure}}::h9508bce7fbf1ad82 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:582:43 [INFO] [stdout] 33: 0x5c9aa101dad4 - test::run_test::{{closure}}::h70f94fa995999514 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/test/src/lib.rs:612:41 [INFO] [stdout] 34: 0x5c9aa101dad4 - std::sys::backtrace::__rust_begin_short_backtrace::hfc7043e7c8324aca [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 35: 0x5c9aa10213ca - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h599c966db81290c0 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 36: 0x5c9aa10213ca - as core::ops::function::FnOnce<()>>::call_once::h499078bec004bb56 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 37: 0x5c9aa10213ca - std::panicking::try::do_call::h336d5bb945571c50 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:589:40 [INFO] [stdout] 38: 0x5c9aa10213ca - std::panicking::try::hea8a9a2c11807957 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panicking.rs:552:19 [INFO] [stdout] 39: 0x5c9aa10213ca - std::panic::catch_unwind::hc46631a6d929f68d [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x5c9aa10213ca - std::thread::Builder::spawn_unchecked_::{{closure}}::he5729da5506c58d1 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 41: 0x5c9aa10213ca - core::ops::function::FnOnce::call_once{{vtable.shim}}::h8b7f1215a4f7e46f [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x5c9aa199b92b - as core::ops::function::FnOnce>::call_once::h5e2c5a5b1d7d1d9c [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 43: 0x5c9aa199b92b - as core::ops::function::FnOnce>::call_once::hc50cd23acd01680e [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 44: 0x5c9aa199b92b - std::sys::pal::unix::thread::Thread::new::thread_start::hb3d0e19f380baa62 [INFO] [stdout] at /rustc/a5948295b4bf4c6199457f1227e5d8f6e6b9f948/library/std/src/sys/pal/unix/thread.rs:109:17 [INFO] [stdout] 45: 0x71c678f2aaa4 - [INFO] [stdout] 46: 0x71c678fb7a34 - clone [INFO] [stdout] 47: 0x0 - [INFO] [stdout] 1744766862 test: Node z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 shutting down.. [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 control: Received `{"command":"shutdown"}` on control socket [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 control: Shutdown requested.. [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b wire: Peer id=2 (fd=299) disconnected [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Disconnected from z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 (connection reset) [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Dropping peer z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2.. [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b service: Not enough available peers to connect to (available=0, wanted=8) [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 fetch: Clone of rad:zHvFBYuxpZRL7R2ozAYYN6LnRuxN from z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b failed with 'Could not access repository or failed to read streaming pack file' (4291ms) [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 worker: Unable to report fetch result: worker channel disconnected [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 pool: Worker pool shutting down.. [INFO] [stdout] 1744766862 z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 node: Node shutdown completed for z6MkvrJxJH8BatFUT2FxFvKpXbPGhqUHWwDYNAiPuEP4feA2 [INFO] [stdout] 1744766862 test: Node z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b shutting down.. [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b control: Received `{"command":"shutdown"}` on control socket [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b control: Shutdown requested.. [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b pool: Worker pool shutting down.. [INFO] [stdout] 1744766862 z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b node: Node shutdown completed for z6MkjNKFNTGrw1S3YJBGix8nZvE1Hi5w3Wn64hWcp2QaB43b [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::e2e::test_large_fetch [INFO] [stdout] [INFO] [stdout] test result: FAILED. 109 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 73.59s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "74a06bed1c3558bdbd806f8434239c165e4afdef90aa2df779387d44470cbc9c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "74a06bed1c3558bdbd806f8434239c165e4afdef90aa2df779387d44470cbc9c", kill_on_drop: false }` [INFO] [stdout] 74a06bed1c3558bdbd806f8434239c165e4afdef90aa2df779387d44470cbc9c