[INFO] fetching crate flnode 0.7.0... [INFO] testing flnode-0.7.0 against try#fc4ba03ef77ca5018fb78a097d3b924d30f15bfc+target=i686-unknown-linux-musl for musl_upgrade_1_2_take4 [INFO] extracting crate flnode 0.7.0 into /workspace/builds/worker-4/source [INFO] validating manifest of crates.io crate flnode 0.7.0 on toolchain fc4ba03ef77ca5018fb78a097d3b924d30f15bfc [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate flnode 0.7.0 [INFO] finished tweaking crates.io crate flnode 0.7.0 [INFO] tweaked toml for crates.io crate flnode 0.7.0 written to /workspace/builds/worker-4/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded ct-codecs v1.1.1 [INFO] [stderr] Downloaded flarch v0.7.0 [INFO] [stderr] Downloaded flmodules v0.7.0 [INFO] [stderr] Downloaded ed25519-compact v1.0.16 [INFO] [stderr] Downloaded flnet v0.7.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 6cd3ac732ba216950d1b277067e64bdc6e0022f88d34d148fe69ace9877ebb8f [INFO] running `Command { std: "docker" "start" "-a" "6cd3ac732ba216950d1b277067e64bdc6e0022f88d34d148fe69ace9877ebb8f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "6cd3ac732ba216950d1b277067e64bdc6e0022f88d34d148fe69ace9877ebb8f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6cd3ac732ba216950d1b277067e64bdc6e0022f88d34d148fe69ace9877ebb8f", kill_on_drop: false }` [INFO] [stdout] 6cd3ac732ba216950d1b277067e64bdc6e0022f88d34d148fe69ace9877ebb8f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "build" "--frozen" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] eb351d01870d9af32e6d6639bc4319be777f3ebdf5c5bfdac57e9d3cafd51064 [INFO] running `Command { std: "docker" "start" "-a" "eb351d01870d9af32e6d6639bc4319be777f3ebdf5c5bfdac57e9d3cafd51064", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.47 [INFO] [stderr] Compiling quote v1.0.21 [INFO] [stderr] Compiling unicode-ident v1.0.5 [INFO] [stderr] Compiling syn v1.0.105 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling wasm-bindgen-shared v0.2.83 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling bumpalo v3.11.1 [INFO] [stderr] Compiling once_cell v1.16.0 [INFO] [stderr] Compiling futures-core v0.3.25 [INFO] [stderr] Compiling serde_derive v1.0.150 [INFO] [stderr] Compiling wasm-bindgen v0.2.83 [INFO] [stderr] Compiling typenum v1.16.0 [INFO] [stderr] Compiling futures-channel v0.3.25 [INFO] [stderr] Compiling futures-task v0.3.25 [INFO] [stderr] Compiling serde v1.0.150 [INFO] [stderr] Compiling pin-project-lite v0.2.9 [INFO] [stderr] Compiling getrandom v0.2.8 [INFO] [stderr] Compiling ident_case v1.0.1 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling futures-sink v0.3.25 [INFO] [stderr] Compiling futures-util v0.3.25 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling generic-array v0.14.6 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling slab v0.4.7 [INFO] [stderr] Compiling indexmap v1.9.2 [INFO] [stderr] Compiling num-traits v0.2.15 [INFO] [stderr] Compiling num-integer v0.1.45 [INFO] [stderr] Compiling tokio v1.23.0 [INFO] [stderr] Compiling futures-io v0.3.25 [INFO] [stderr] Compiling aho-corasick v0.7.20 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling ryu v1.0.11 [INFO] [stderr] Compiling regex-syntax v0.6.28 [INFO] [stderr] Compiling serde_json v1.0.89 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling thiserror v1.0.37 [INFO] [stderr] Compiling itoa v1.0.4 [INFO] [stderr] Compiling linked-hash-map v0.5.6 [INFO] [stderr] Compiling iana-time-zone v0.1.53 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling os_str_bytes v6.4.1 [INFO] [stderr] Compiling humantime v2.1.0 [INFO] [stderr] Compiling async-trait v0.1.59 [INFO] [stderr] Compiling scoped-tls v1.0.1 [INFO] [stderr] Compiling heck v0.4.0 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling yaml-rust v0.4.5 [INFO] [stderr] Compiling either v1.8.0 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling wasm-bindgen-test-macro v0.3.33 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling names v0.14.0 [INFO] [stderr] Compiling cpufeatures v0.2.5 [INFO] [stderr] Compiling textwrap v0.16.0 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling ct-codecs v1.1.1 [INFO] [stderr] Compiling bimap v0.6.2 [INFO] [stderr] Compiling regex v1.7.0 [INFO] [stderr] Compiling ed25519-compact v1.0.16 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling block-buffer v0.10.3 [INFO] [stderr] Compiling chrono v0.4.23 [INFO] [stderr] Compiling digest v0.10.6 [INFO] [stderr] Compiling sha2 v0.10.6 [INFO] [stderr] Compiling env_logger v0.9.3 [INFO] [stderr] Compiling wasm-bindgen-backend v0.2.83 [INFO] [stderr] Compiling darling_core v0.13.4 [INFO] [stderr] Compiling wasm-bindgen-macro-support v0.2.83 [INFO] [stderr] Compiling futures-macro v0.3.25 [INFO] [stderr] Compiling tokio-macros v1.8.2 [INFO] [stderr] Compiling thiserror-impl v1.0.37 [INFO] [stderr] Compiling clap_derive v3.2.18 [INFO] [stderr] Compiling wasm-bindgen-macro v0.2.83 [INFO] [stderr] Compiling darling_macro v0.13.4 [INFO] [stderr] Compiling darling v0.13.4 [INFO] [stderr] Compiling serde_with_macros v1.5.2 [INFO] [stderr] Compiling js-sys v0.3.60 [INFO] [stderr] Compiling console_error_panic_hook v0.1.7 [INFO] [stderr] Compiling clap v3.2.23 [INFO] [stderr] Compiling tokio-stream v0.1.11 [INFO] [stderr] Compiling wasm-bindgen-futures v0.4.33 [INFO] [stderr] Compiling futures-executor v0.3.25 [INFO] [stderr] Compiling wasm-bindgen-test v0.3.33 [INFO] [stderr] Compiling futures v0.3.25 [INFO] [stderr] Compiling flarch v0.7.0 [INFO] [stderr] Compiling serde_yaml v0.8.26 [INFO] [stderr] Compiling toml v0.5.9 [INFO] [stderr] Compiling serde_with v1.14.0 [INFO] [stderr] Compiling flmodules v0.7.0 [INFO] [stderr] Compiling flnet v0.7.1 [INFO] [stderr] Compiling flnode v0.7.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 21.82s [INFO] running `Command { std: "docker" "inspect" "eb351d01870d9af32e6d6639bc4319be777f3ebdf5c5bfdac57e9d3cafd51064", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "eb351d01870d9af32e6d6639bc4319be777f3ebdf5c5bfdac57e9d3cafd51064", kill_on_drop: false }` [INFO] [stdout] eb351d01870d9af32e6d6639bc4319be777f3ebdf5c5bfdac57e9d3cafd51064 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--no-run" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] fe27a470e4cbe2e3fb42a475f02e2dd73e0f16848cb6bbcc3d525badb9b80df1 [INFO] running `Command { std: "docker" "start" "-a" "fe27a470e4cbe2e3fb42a475f02e2dd73e0f16848cb6bbcc3d525badb9b80df1", kill_on_drop: false }` [INFO] [stderr] Compiling flnode v0.7.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 6.15s [INFO] running `Command { std: "docker" "inspect" "fe27a470e4cbe2e3fb42a475f02e2dd73e0f16848cb6bbcc3d525badb9b80df1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fe27a470e4cbe2e3fb42a475f02e2dd73e0f16848cb6bbcc3d525badb9b80df1", kill_on_drop: false }` [INFO] [stdout] fe27a470e4cbe2e3fb42a475f02e2dd73e0f16848cb6bbcc3d525badb9b80df1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] fc2b968a8a9cb1fa56bba1c4574d9ccc889041f2fd59a19b78ff2dc3dcb3bcae [INFO] running `Command { std: "docker" "start" "-a" "fc2b968a8a9cb1fa56bba1c4574d9ccc889041f2fd59a19b78ff2dc3dcb3bcae", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.13s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/flnode-1f45518091b0814d) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: female-potato = aab7e995dce6cfef [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: hesitant-connection = d0d098e14d791027 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG flnode::node::tests] storage is: EventsStorage { storage: {TextMessage: Events { config: CategoryConfig { unique: false, max_events: 50 }, events: {} }, NodeInfo: Events { config: CategoryConfig { unique: true, max_events: 100 }, events: {3463f238dcd02675-9e3f963dcf0a768b-e62dc2abe3a04eec-03ee4df0bf7b183f: Event { category: NodeInfo, src: aab7e995dce6cfef-6554ce307544db7f-2e5effecc9b2279a-e26c664749cf496f, created: 1670952802136, msg: "---\nNodeInfoV2:\n name: female-potato\n client: libc\n pubkey: qrfpldzmz+9lVM4wdUTbfy5e/+zJsiea4mxmR0nPSW8=\n" }} }} } [INFO] [stdout] test node::tests::test_store_node ... ok [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: hesitant-connection = d0d098e14d791027 [INFO] [stdout] test node::tests::test_storage ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/gossip_events.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/gossip_events-e8e360f38919c8dd) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Creating 30 nodes [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Creating 2 nodes [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: modern-cellar = 04bb4076ecbdc7e8 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: striped-brake = 0b82d3a97bad8002 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: capable-pest = 162c4a22f0791612 [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Adding 1st message [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #0 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #1 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: eatable-hour = 1fc1c31bf68530b5 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #2 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #3 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #2 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #2 [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Checking messages 2 == 2 and adding 2nd message [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #5 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #3 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #6 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #7 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #8 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Checking messages 4 == 4 and adding 2 nodes [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: gainful-quince = 28912b576bf5ad8e [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: laughable-paint = 223a4cdb6eb6f9a6 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: ripe-believe = 37612a54de14911f [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #9 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: icky-giraffe = 33283da2d8553047 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #10 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: friendly-frog = 44cfe45eb34cbe43 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: three-recess = 557b63804905f4fc [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #11 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: incompetent-afternoon = 6bf5a16134ad3f9f [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: puffy-land = 7e5574dffc8fb043 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #4 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #12 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #8 [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Checking messages 8 == 8 [INFO] [stdout] test gossip_2 ... ok [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: cool-mice = 8839e7be62f01d14 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: heavenly-men = 96b706d7171db346 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: lumpy-beggar = a2d4d12904e9f23f [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: whispering-crow = bf58723121246fe5 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: ossified-aftermath = c0fd60fe497bd72d [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: public-playground = d231161b9589e760 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: nebulous-hour = e87837f7e95a2901 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: living-insect = f2593b68ec643dfd [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: light-bread = 02ff818cf2ed6429 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: domineering-art = 1dcef74f0040be89 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: pink-sun = 2299f3fc59b6858b [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: workable-mine = 3b45c6a212837c3c [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: toothsome-thought = 41f2503f31f89b40 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: aback-nation = 58f1f544dc81a98a [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: jazzy-bells = 6c05c557f96364cb [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: entertaining-things = 704afc30042ac795 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: shaggy-bulb = 8b2cfca55a0595e6 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: salty-rice = 978fd558648d5b10 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: acid-band = af9c6f39ba1418a8 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: lamentable-face = b9acf738cf34992f [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: smelly-insect = c35a984d23a59932 [INFO] [stderr] [2022-12-13T17:33:22Z INFO flnode::node] Starting node: elfin-wine = d5b817004a3ffbf8 [INFO] [stderr] [2022-12-13T17:33:22Z INFO gossip_events] Adding 1st message [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #0 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:22Z DEBUG gossip_events] Process #1 [INFO] [stderr] [2022-12-13T17:33:23Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:23Z DEBUG gossip_events] Process #2 [INFO] [stderr] [2022-12-13T17:33:23Z DEBUG gossip_events] Messages in network: #1 [INFO] [stderr] [2022-12-13T17:33:23Z DEBUG gossip_events] Process #3 [INFO] [stderr] [2022-12-13T17:33:25Z DEBUG gossip_events] Messages in network: #7 [INFO] [stderr] [2022-12-13T17:33:25Z DEBUG gossip_events] Process #4 [INFO] [stderr] [2022-12-13T17:33:29Z DEBUG gossip_events] Messages in network: #25 [INFO] [stderr] [2022-12-13T17:33:29Z DEBUG gossip_events] Process #5 [INFO] [stderr] [2022-12-13T17:33:31Z DEBUG gossip_events] Messages in network: #29 [INFO] [stderr] [2022-12-13T17:33:31Z INFO gossip_events] Checking messages 30 == 29 and adding 2nd message [INFO] [stdout] test gossip_30 ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- gossip_30 stdout ---- [INFO] [stdout] thread 'gossip_30' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `30`, [INFO] [stdout] right: `29`', tests/gossip_events.rs:52:17 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x8564041 - std::backtrace_rs::backtrace::libunwind::trace::h5f291319ef5c6762 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x8564041 - std::backtrace_rs::backtrace::trace_unsynchronized::h96ca96ef06a343d3 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x8564041 - std::sys_common::backtrace::_print_fmt::h9ecddad7ef420251 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:65:5 [INFO] [stdout] 3: 0x8564041 - ::fmt::h7345cc970529ac34 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:44:22 [INFO] [stdout] 4: 0x85a39fc - core::fmt::write::hf580cd49f879cb74 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/fmt/mod.rs:1208:17 [INFO] [stdout] 5: 0x8560feb - std::io::Write::write_fmt::hceb49ab886ea57c9 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/io/mod.rs:1682:15 [INFO] [stdout] 6: 0x8563e46 - std::sys_common::backtrace::_print::h8b6713f1e30cd3b1 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:47:5 [INFO] [stdout] 7: 0x8563e46 - std::sys_common::backtrace::print::h228371403e861751 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:34:9 [INFO] [stdout] 8: 0x8565a25 - std::panicking::default_hook::{{closure}}::h6da55f6f475e59d6 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:267:22 [INFO] [stdout] 9: 0x8565725 - std::panicking::default_hook::h8f14cf6f2f2f52d8 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:283:9 [INFO] [stdout] 10: 0x8542b2c - core::ops::function::Fn::call::h9b26c25f04212ebd [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:161:5 [INFO] [stdout] 11: 0x81939b9 - as core::ops::function::Fn>::call::h0b6006386399b354 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2032:9 [INFO] [stdout] 12: 0x81939b9 - test::test_main::{{closure}}::hf462dccab4831d1f [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:135:21 [INFO] [stdout] 13: 0x8566164 - as core::ops::function::Fn>::call::h9163b46de7e7a7ba [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2032:9 [INFO] [stdout] 14: 0x8566164 - std::panicking::rust_panic_with_hook::h2f79ffe424d88114 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:692:13 [INFO] [stdout] 15: 0x8565f1c - std::panicking::begin_panic_handler::{{closure}}::h59ef6a1246219cbe [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:579:13 [INFO] [stdout] 16: 0x85644ba - std::sys_common::backtrace::__rust_end_short_backtrace::h3d3587da31656282 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:137:18 [INFO] [stdout] 17: 0x8565bf3 - rust_begin_unwind [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:575:5 [INFO] [stdout] 18: 0x804c670 - core::panicking::panic_fmt::h40e949315ccf1c11 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panicking.rs:64:14 [INFO] [stdout] 19: 0x804ca2b - core::panicking::assert_failed_inner::h1e71a98e19ea3237 [INFO] [stdout] 20: 0x850133d - core::panicking::assert_failed::h1f3fc2fd57383c8d [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panicking.rs:199:5 [INFO] [stdout] 21: 0x80dd2ac - gossip_events::gossip::{{closure}}::hc56340b2b2495bb0 [INFO] [stdout] at /opt/rustwide/workdir/tests/gossip_events.rs:52:17 [INFO] [stdout] 22: 0x80dee6f - gossip_events::gossip_30::{{closure}}::hd8b5d04adc8f2be2 [INFO] [stdout] at /opt/rustwide/workdir/tests/gossip_events.rs:16:15 [INFO] [stdout] 23: 0x810e8c2 - as core::future::future::Future>::poll::h0de16c4adfe58f8d [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x810ebc0 - as core::future::future::Future>::poll::h5387e881e6d25eaf [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/future/future.rs:124:9 [INFO] [stdout] 25: 0x80bfcbb - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::hde87279a8d803708 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:541:57 [INFO] [stdout] 26: 0x80bfb54 - tokio::runtime::coop::with_budget::ha6848c407e59f51f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/coop.rs:102:5 [INFO] [stdout] 27: 0x80bfb54 - tokio::runtime::coop::budget::h12312fb96601842c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/coop.rs:68:5 [INFO] [stdout] 28: 0x80bfb54 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h1cb9c6acea0f93a2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:541:25 [INFO] [stdout] 29: 0x80be69d - tokio::runtime::scheduler::current_thread::Context::enter::hbc9e908a3a718a0f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:350:19 [INFO] [stdout] 30: 0x80bf2e5 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h89792573b0d233a8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:540:36 [INFO] [stdout] 31: 0x80bf007 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h69d8a8b2fddde413 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:615:57 [INFO] [stdout] 32: 0x80b5666 - tokio::macros::scoped_tls::ScopedKey::set::h18a3fa133a79d91a [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 33: 0x80bedfa - tokio::runtime::scheduler::current_thread::CoreGuard::enter::hbe85591a0a145461 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:615:27 [INFO] [stdout] 34: 0x80bf07e - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::hb50bcfda6fc04236 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:530:19 [INFO] [stdout] 35: 0x80bc843 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h91d2896c530c072d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/scheduler/current_thread.rs:154:24 [INFO] [stdout] 36: 0x80b57c8 - tokio::runtime::runtime::Runtime::block_on::hcd689ad30c4db726 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.23.0/src/runtime/runtime.rs:282:47 [INFO] [stdout] 37: 0x80dec0f - gossip_events::gossip_30::h58ed1b88275dde6e [INFO] [stdout] at /opt/rustwide/workdir/tests/gossip_events.rs:17:5 [INFO] [stdout] 38: 0x80dea1d - gossip_events::gossip_30::{{closure}}::h157253fbc0344890 [INFO] [stdout] at /opt/rustwide/workdir/tests/gossip_events.rs:15:25 [INFO] [stdout] 39: 0x814685d - core::ops::function::FnOnce::call_once::h582ea23cf5ea29d9 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5 [INFO] [stdout] 40: 0x81983fe - core::ops::function::FnOnce::call_once::hecc3c5fab6cb88cd [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5 [INFO] [stdout] 41: 0x81983fe - test::__rust_begin_short_backtrace::h18e977d49f646cd0 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:657:18 [INFO] [stdout] 42: 0x816b3a0 - test::run_test::{{closure}}::ha39325b57d1cb768 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:648:30 [INFO] [stdout] 43: 0x816b3a0 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h5040e45b1e845123 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5 [INFO] [stdout] 44: 0x8197577 - as core::ops::function::FnOnce>::call_once::h26c70f40318b0360 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9 [INFO] [stdout] 45: 0x8197577 - as core::ops::function::FnOnce<()>>::call_once::hfa679c02d5269ea1 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 46: 0x8197577 - std::panicking::try::do_call::h5bc1d3d4ab3d7acd [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:483:40 [INFO] [stdout] 47: 0x8197577 - std::panicking::try::h0d0734d848512873 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:447:19 [INFO] [stdout] 48: 0x8197577 - std::panic::catch_unwind::h1b17ff745af6bff3 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panic.rs:137:14 [INFO] [stdout] 49: 0x8197577 - test::run_test_in_process::h7545f915ef03cbbe [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:680:27 [INFO] [stdout] 50: 0x8197577 - test::run_test::run_test_inner::{{closure}}::he5f64ab41218f776 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:574:39 [INFO] [stdout] 51: 0x8165c0a - test::run_test::run_test_inner::{{closure}}::h74ad460a34a68702 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:601:37 [INFO] [stdout] 52: 0x8165c0a - std::sys_common::backtrace::__rust_begin_short_backtrace::h3e8f4d074e786dcf [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:121:18 [INFO] [stdout] 53: 0x816b21b - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h9aa166e39b65b836 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/thread/mod.rs:550:17 [INFO] [stdout] 54: 0x816b21b - as core::ops::function::FnOnce<()>>::call_once::h49c1c6ee61f36b13 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 55: 0x816b21b - std::panicking::try::do_call::h6c0758e2b02f2859 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:483:40 [INFO] [stdout] 56: 0x816b21b - std::panicking::try::h3684f436e633cc77 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:447:19 [INFO] [stdout] 57: 0x816b21b - std::panic::catch_unwind::hc37306cbaab1bf43 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panic.rs:137:14 [INFO] [stdout] 58: 0x816b21b - std::thread::Builder::spawn_unchecked_::{{closure}}::h6a4963ec3f0e3be6 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/thread/mod.rs:549:30 [INFO] [stdout] 59: 0x816b21b - core::ops::function::FnOnce::call_once{{vtable.shim}}::h0914fb32932929dc [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5 [INFO] [stdout] 60: 0x8569dcd - as core::ops::function::FnOnce>::call_once::hb6157d95beb62c18 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9 [INFO] [stdout] 61: 0x8569dcd - as core::ops::function::FnOnce>::call_once::h710bd3383b288449 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9 [INFO] [stdout] 62: 0x8569dcd - std::sys::unix::thread::Thread::new::thread_start::ha4036db4cbfe1239 [INFO] [stdout] at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] gossip_30 [INFO] [stdout] [INFO] [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.66s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test gossip_events` [INFO] running `Command { std: "docker" "inspect" "fc2b968a8a9cb1fa56bba1c4574d9ccc889041f2fd59a19b78ff2dc3dcb3bcae", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fc2b968a8a9cb1fa56bba1c4574d9ccc889041f2fd59a19b78ff2dc3dcb3bcae", kill_on_drop: false }` [INFO] [stdout] fc2b968a8a9cb1fa56bba1c4574d9ccc889041f2fd59a19b78ff2dc3dcb3bcae