[INFO] fetching crate kaspa-notify 0.0.3...
[INFO] testing kaspa-notify-0.0.3 against 1.69.0 for beta-1.70-1
[INFO] extracting crate kaspa-notify 0.0.3 into /workspace/builds/worker-2-tc1/source
[INFO] validating manifest of crates.io crate kaspa-notify 0.0.3 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate kaspa-notify 0.0.3
[INFO] finished tweaking crates.io crate kaspa-notify 0.0.3
[INFO] tweaked toml for crates.io crate kaspa-notify 0.0.3 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" __CARGO_TEST_CHANNEL_OVERRIDE_DO_NOT_USE_THIS="nightly" "/workspace/cargo-home/bin/cargo" "+1.69.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded workflow-core v0.3.14
[INFO] [stderr]   Downloaded kaspa-txscript v0.0.3
[INFO] [stderr]   Downloaded workflow-log v0.3.14
[INFO] [stderr]   Downloaded workflow-panic-hook v0.3.14
[INFO] [stderr]   Downloaded workflow-wasm v0.3.14
[INFO] [stderr]   Downloaded kaspa-consensus-core v0.0.3
[INFO] [stderr]   Downloaded kaspa-math v0.0.3
[INFO] [stderr]   Downloaded embed-doc-image v0.1.4
[INFO] [stderr]   Downloaded linkme-impl v0.2.10
[INFO] [stderr]   Downloaded intertrait-macros v0.2.2
[INFO] [stderr]   Downloaded intertrait v0.2.2
[INFO] [stderr]   Downloaded kaspa-core v0.0.3
[INFO] [stderr]   Downloaded kaspa-merkle v0.0.3
[INFO] [stderr]   Downloaded kaspa-hashes v0.0.3
[INFO] [stderr]   Downloaded hexplay v0.2.1
[INFO] [stderr]   Downloaded kaspa-txscript-errors v0.0.3
[INFO] [stderr]   Downloaded malachite-base v0.3.2
[INFO] [stderr]   Downloaded ctrlc v3.2.5
[INFO] [stderr]   Downloaded kaspa-utils v0.0.3
[INFO] [stderr]   Downloaded kaspa-addresses v0.0.3
[INFO] [stderr]   Downloaded linkme v0.2.10
[INFO] [stderr]   Downloaded kaspa-muhash v0.0.3
[INFO] [stderr]   Downloaded malachite-nz v0.3.2
[INFO] [stderr]   Downloaded workflow-wasm-macros v0.3.14
[INFO] [stderr]   Downloaded faster-hex v0.6.1
[INFO] [stderr]   Downloaded triggered v0.1.2
[INFO] [stderr]   Downloaded workflow-async-trait v0.1.68
[INFO] [stderr]   Downloaded parse-variants-derive v0.1.0
[INFO] [stderr]   Downloaded parse-variants v0.1.1
[INFO] [stderr]   Downloaded workflow-macro-tools v0.3.14
[INFO] [stderr]   Downloaded workflow-core-macros v0.3.14
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5fb31684743f6c8c008be841d5d2a35d0582342ea4e8be6ff7b0591870cdbd95
[INFO] running `Command { std: "docker" "start" "-a" "5fb31684743f6c8c008be841d5d2a35d0582342ea4e8be6ff7b0591870cdbd95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5fb31684743f6c8c008be841d5d2a35d0582342ea4e8be6ff7b0591870cdbd95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5fb31684743f6c8c008be841d5d2a35d0582342ea4e8be6ff7b0591870cdbd95", kill_on_drop: false }`
[INFO] [stdout] 5fb31684743f6c8c008be841d5d2a35d0582342ea4e8be6ff7b0591870cdbd95
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] eff68213ffccde12a79f04bc2ca526999368417716c8a85592553aa807b3fba3
[INFO] running `Command { std: "docker" "start" "-a" "eff68213ffccde12a79f04bc2ca526999368417716c8a85592553aa807b3fba3", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling value-bag v1.0.0-alpha.9
[INFO] [stderr]    Compiling serde v1.0.160
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.84
[INFO] [stderr]    Compiling futures-core v0.3.28
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling getrandom v0.2.9
[INFO] [stderr]    Compiling bumpalo v3.12.1
[INFO] [stderr]    Compiling ryu v1.0.13
[INFO] [stderr]    Compiling typenum v1.16.0
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling serde_json v1.0.96
[INFO] [stderr]    Compiling wasm-bindgen v0.2.84
[INFO] [stderr]    Compiling itoa v1.0.6
[INFO] [stderr]    Compiling pin-project-lite v0.2.9
[INFO] [stderr]    Compiling slab v0.4.8
[INFO] [stderr]    Compiling crossbeam-utils v0.8.15
[INFO] [stderr]    Compiling futures-io v0.3.28
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling event-listener v2.5.3
[INFO] [stderr]    Compiling rustix v0.37.18
[INFO] [stderr]    Compiling ahash v0.7.6
[INFO] [stderr]    Compiling futures-task v0.3.28
[INFO] [stderr]    Compiling parking v2.1.0
[INFO] [stderr]    Compiling concurrent-queue v2.2.0
[INFO] [stderr]    Compiling futures-channel v0.3.28
[INFO] [stderr]    Compiling waker-fn v1.1.0
[INFO] [stderr]    Compiling async-lock v2.7.0
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling futures-lite v1.13.0
[INFO] [stderr]    Compiling polling v2.8.0
[INFO] [stderr]    Compiling futures-sink v0.3.28
[INFO] [stderr]    Compiling cc v1.0.79
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling futures-util v0.3.28
[INFO] [stderr]    Compiling async-channel v1.8.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling async-io v1.13.0
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling async-task v4.4.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling socket2 v0.4.9
[INFO] [stderr]    Compiling tokio v1.28.0
[INFO] [stderr]    Compiling atomic-waker v1.1.1
[INFO] [stderr]    Compiling unicode-segmentation v1.10.1
[INFO] [stderr]    Compiling digest v0.10.6
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling async-executor v1.5.1
[INFO] [stderr]    Compiling convert_case v0.6.0
[INFO] [stderr]    Compiling num_cpus v1.15.0
[INFO] [stderr]    Compiling borsh-derive-internal v0.9.3
[INFO] [stderr]    Compiling borsh-schema-derive-internal v0.9.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling cpufeatures v0.2.7
[INFO] [stderr]    Compiling serde_derive v1.0.160
[INFO] [stderr]    Compiling futures-macro v0.3.28
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling tokio-macros v2.1.0
[INFO] [stderr]    Compiling termcolor v0.3.6
[INFO] [stderr]    Compiling unicode-width v0.1.10
[INFO] [stderr]    Compiling bytes v1.4.0
[INFO] [stderr]    Compiling workflow-async-trait v0.1.68
[INFO] [stderr]    Compiling hexplay v0.2.1
[INFO] [stderr]    Compiling console v0.15.5
[INFO] [stderr]    Compiling sha2 v0.10.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling faster-hex v0.6.1
[INFO] [stderr]    Compiling triggered v0.1.2
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling block-padding v0.2.1
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling keccak v0.1.3
[INFO] [stderr]    Compiling bs58 v0.4.0
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling sha3 v0.9.1
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling kaspa-hashes v0.0.3
[INFO] [stderr]    Compiling secp256k1-sys v0.6.1
[INFO] [stderr]    Compiling arrayref v0.3.7
[INFO] [stderr]    Compiling ctor v0.1.26
[INFO] [stderr]    Compiling parse-variants-derive v0.1.0
[INFO] [stderr]    Compiling async-attributes v1.1.2
[INFO] [stderr]    Compiling arrayvec v0.7.2
[INFO] [stderr]    Compiling constant_time_eq v0.2.5
[INFO] [stderr]    Compiling base64 v0.13.1
[INFO] [stderr]    Compiling blake2b_simd v1.0.1
[INFO] [stderr]    Compiling parse-variants v0.1.1
[INFO] [stderr]    Compiling workflow-macro-tools v0.3.14
[INFO] [stderr]    Compiling workflow-core-macros v0.3.14
[INFO] [stderr]    Compiling embed-doc-image v0.1.4
[INFO] [stderr]    Compiling wasm-bindgen-backend v0.2.84
[INFO] [stderr]    Compiling blocking v1.3.1
[INFO] [stderr]    Compiling kv-log-macro v1.0.7
[INFO] [stderr]    Compiling futures-executor v0.3.28
[INFO] [stderr]    Compiling futures v0.3.28
[INFO] [stderr]    Compiling malachite-base v0.3.2
[INFO] [stderr]    Compiling linkme-impl v0.2.10
[INFO] [stderr]    Compiling async-global-executor v2.3.1
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.84
[INFO] [stderr]    Compiling async-std v1.12.0
[INFO] [stderr]    Compiling aho-corasick v1.0.1
[INFO] [stderr]    Compiling uuid v0.8.2
[INFO] [stderr]    Compiling regex-syntax v0.7.1
[INFO] [stderr]    Compiling intertrait-macros v0.2.2
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.84
[INFO] [stderr]    Compiling regex v1.8.1
[INFO] [stderr]    Compiling toml v0.5.11
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling nix v0.26.2
[INFO] [stderr]    Compiling proc-macro-crate v0.1.5
[INFO] [stderr]    Compiling linkme v0.2.10
[INFO] [stderr]    Compiling is-terminal v0.4.7
[INFO] [stderr]    Compiling js-sys v0.3.61
[INFO] [stderr]    Compiling lock_api v0.4.9
[INFO] [stderr]    Compiling workflow-log v0.3.14
[INFO] [stderr]    Compiling borsh-derive v0.9.3
[INFO] [stderr]    Compiling async-trait v0.1.68
[INFO] [stderr]    Compiling termcolor v1.2.0
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.7
[INFO] [stderr]    Compiling env_logger v0.10.0
[INFO] [stderr]    Compiling ctrlc v3.2.5
[INFO] [stderr]    Compiling intertrait v0.2.2
[INFO] [stderr]    Compiling secp256k1 v0.24.3
[INFO] [stderr]    Compiling borsh v0.9.3
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling kaspa-core v0.0.3
[INFO] [stderr]    Compiling kaspa-txscript-errors v0.0.3
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling kaspa-addresses v0.0.3
[INFO] [stderr]    Compiling hashbrown v0.12.3
[INFO] [stderr]    Compiling serde-wasm-bindgen v0.4.5
[INFO] [stderr]    Compiling web-sys v0.3.61
[INFO] [stderr]    Compiling wasm-bindgen-futures v0.4.34
[INFO] [stderr]    Compiling parking_lot v0.12.1
[INFO] [stderr]    Compiling convert_case v0.4.0
[INFO] [stderr]    Compiling workflow-wasm-macros v0.3.14
[INFO] [stderr]    Compiling workflow-core v0.3.14
[INFO] [stderr]    Compiling derive_more v0.99.17
[INFO] [stderr]    Compiling kaspa-utils v0.0.3
[INFO] [stderr]    Compiling malachite-nz v0.3.2
[INFO] [stderr]    Compiling workflow-panic-hook v0.3.14
[INFO] [stderr]    Compiling workflow-wasm v0.3.14
[INFO] [stderr]    Compiling kaspa-merkle v0.0.3
[INFO] [stderr]    Compiling kaspa-math v0.0.3
[INFO] [stderr]    Compiling kaspa-muhash v0.0.3
[INFO] [stderr]    Compiling kaspa-consensus-core v0.0.3
[INFO] [stderr]    Compiling kaspa-txscript v0.0.3
[INFO] [stderr]    Compiling kaspa-notify v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 06s
[INFO] running `Command { std: "docker" "inspect" "eff68213ffccde12a79f04bc2ca526999368417716c8a85592553aa807b3fba3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eff68213ffccde12a79f04bc2ca526999368417716c8a85592553aa807b3fba3", kill_on_drop: false }`
[INFO] [stdout] eff68213ffccde12a79f04bc2ca526999368417716c8a85592553aa807b3fba3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 716ed43c7afc8f3fc468aaf0121dcaf2c24920adddaf58b92c6f1f8eca1a5ad6
[INFO] running `Command { std: "docker" "start" "-a" "716ed43c7afc8f3fc468aaf0121dcaf2c24920adddaf58b92c6f1f8eca1a5ad6", kill_on_drop: false }`
[INFO] [stderr]    Compiling kaspa-notify v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.34s
[INFO] running `Command { std: "docker" "inspect" "716ed43c7afc8f3fc468aaf0121dcaf2c24920adddaf58b92c6f1f8eca1a5ad6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "716ed43c7afc8f3fc468aaf0121dcaf2c24920adddaf58b92c6f1f8eca1a5ad6", kill_on_drop: false }`
[INFO] [stdout] 716ed43c7afc8f3fc468aaf0121dcaf2c24920adddaf58b92c6f1f8eca1a5ad6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8a6c21b29e8f780592f0f883c51b501f517aee002e2474b8b0421a758c57b40e
[INFO] running `Command { std: "docker" "start" "-a" "8a6c21b29e8f780592f0f883c51b501f517aee002e2474b8b0421a758c57b40e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.29s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kaspa_notify-f3968e7b09669bb7)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #1 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #2 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #2 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #3 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #3 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #4 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 1 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #1 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 2 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #2 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #2 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 3 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #3 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #1 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #2 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #3 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #3 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task start
[INFO] [stdout] test broadcaster::tests::test_virtual_chain_changed ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 2
[INFO] [stdout] test broadcaster::tests::test_overall ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 0
[INFO] [stdout] test collector::tests::test_collector_from ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task end
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #6 to listener 0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #6 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] started
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #0: do nothing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #0 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task start
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #1: L0 on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1688386546958128344 notifications of scope BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1688386546958128344 about BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #7 to listener 1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #7 to listener 2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #8 to listener 2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 1 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #1 to listener 1688386546958128344
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #2: L0 & L1 on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 9782766615985766118 notifications of scope BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 9782766615985766118 about BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 2 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #2 to listener 1688386546958128344
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #2 to listener 9782766615985766118
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #3: L1 on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 1688386546958128344 notifications of scope BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 1688386546958128344 about BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #3
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] apply_overall_subscription: BlockAdded(BlockAddedNotification { data: 3 }), OverallSubscription { event_type: BlockAdded, active: true }
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification BlockAdded #3 to listener 9782766615985766118
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #4: all off
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 9782766615985766118 notifications of scope BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 9782766615985766118 about BlockAdded(BlockAddedScope)
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #4
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task end
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stopped
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] started
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #0: do nothing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #0 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task start
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #1: L0[0] <= N[0]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 15485182907002542083 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 15485182907002542083 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #1 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #2: L0[0] <= N[0,1,2]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 15485182907002542083 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 15485182907002542083 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #2 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #3: L0[0], L1[1] <= N[0,1,2]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1378046762460782906 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1378046762460782906 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #3
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #3 to listener 1378046762460782906
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #3 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #4: L0[0], L1[1], L2[2] <= N[0,1,2]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 16328934361761055817 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 16328934361761055817 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #4
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 1378046762460782906
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 16328934361761055817
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #4 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #5: L0[0, 2], L1[*], L2[1, 2] <= N[0,1,2]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 15485182907002542083 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 15485182907002542083 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1378046762460782906 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1378046762460782906 about UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 16328934361761055817 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 16328934361761055817 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #5
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 1378046762460782906
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #5 to listener 16328934361761055817
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #6: L0[0, 2], L1[*], L2[1, 2] <= N[0]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #6
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #6 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #6 to listener 1378046762460782906
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #6 to listener 15485182907002542083
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #7: L0[2], L1[1], L2[*] <= N[0, 1]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 15485182907002542083 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 15485182907002542083 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #7 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1378046762460782906 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1378046762460782906 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #7 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 16328934361761055817 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 16328934361761055817 about UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #7 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #7
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #7 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #7 to listener 1378046762460782906
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #7 to listener 16328934361761055817
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #8: L2[*] <= N[0, 1, 2]
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 15485182907002542083 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 15485182907002542083 about UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #8 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 1378046762460782906 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 1378046762460782906 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #8 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 16328934361761055817 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 16328934361761055817 about UtxosChanged(UtxosChangedScope { addresses: [Address { prefix: Mainnet, version: PubKey, payload: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1] }] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #8 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #8
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #8 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification UtxosChanged #8 to listener 16328934361761055817
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #9: all off
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 16328934361761055817 notifications of scope UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 16328934361761055817 about UtxosChanged(UtxosChangedScope { addresses: [] })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #9 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #9
[INFO] [stdout] test broadcaster::tests::test_utxos_changed ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #9 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task end
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stopped
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Starting notification broadcasting task
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] started
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #0: do nothing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #0 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task start
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #1: L0+ on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 17367420383711749458 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 17367420383711749458 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #1 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #1 to listener 17367420383711749458
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #2: L0+ & L1- on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1518357507842110225 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1518357507842110225 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #2
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #2 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #2 to listener 1518357507842110225
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #2 to listener 17367420383711749458
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #3: L0- & L1+ on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 17367420383711749458 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 17367420383711749458 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after subscribing
[INFO] [stdout] test notifier::tests::test_overall ... ok
[INFO] [stdout] test subscription::array::tests::test_array_builder ... ok
[INFO] [stdout] test notifier::tests::test_utxos_changed ... ok
[INFO] [stdout] test subscription::single::tests::test_overall_mutation ... ok
[INFO] [stdout] test subscription::single::tests::test_subscription_hash ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start sending to listener 1518357507842110225 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] start notifying to 1518357507842110225 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #3
[INFO] [stdout] test subscription::single::tests::test_utxos_changed_mutation ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #3 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #3 to listener 17367420383711749458
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #3 to listener 1518357507842110225
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #4: L1+ on
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #0
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 17367420383711749458 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 17367420383711749458 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: false })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #4
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #4 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Broadcaster-test] sent notification VirtualChainChanged #4 to listener 1518357507842110225
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Execute test step #5: all off
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Mutation #1
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop sending to listener 1518357507842110225 notifications of scope VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stop notifying to 1518357507842110225 about VirtualChainChanged(VirtualChainChangedScope { include_accepted_transaction_ids: true })
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after subscribing
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Sending notification #5
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] Receiving sync message #5 after notifying
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Collector] collecting_task end
[INFO] [stdout] test notifier::tests::test_virtual_chain_changed ... ok
[INFO] [stderr] [2023-04-30T03:59:50Z TRACE] [Notifier-test] stopped
[INFO] [stdout] test subscription::single::tests::test_virtual_chain_changed_mutation ... ok
[INFO] [stdout] test subscription::compounded::tests::test_overall_compounding ... ok
[INFO] [stderr]    Doc-tests kaspa-notify
[INFO] [stdout] test subscription::compounded::tests::test_utxos_changed_compounding ... ok
[INFO] [stdout] test subscription::compounded::tests::test_virtual_chain_changed_compounding ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "8a6c21b29e8f780592f0f883c51b501f517aee002e2474b8b0421a758c57b40e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a6c21b29e8f780592f0f883c51b501f517aee002e2474b8b0421a758c57b40e", kill_on_drop: false }`
[INFO] [stdout] 8a6c21b29e8f780592f0f883c51b501f517aee002e2474b8b0421a758c57b40e
