Node ID






Columns











Log Level






Log Marker










Class














































node2 0.000ns 2025-10-02 10:18:03.013 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 89.000ms 2025-10-02 10:18:03.102 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 220.000ms 2025-10-02 10:18:03.233 3 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 226.000ms 2025-10-02 10:18:03.239 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 255.000ms 2025-10-02 10:18:03.268 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 256.000ms 2025-10-02 10:18:03.269 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 257.000ms 2025-10-02 10:18:03.270 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 257.000ms 2025-10-02 10:18:03.270 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 258.000ms 2025-10-02 10:18:03.271 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 258.000ms 2025-10-02 10:18:03.271 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 258.000ms 2025-10-02 10:18:03.271 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 259.000ms 2025-10-02 10:18:03.272 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 260.000ms 2025-10-02 10:18:03.273 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 260.000ms 2025-10-02 10:18:03.273 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 260.000ms 2025-10-02 10:18:03.273 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 261.000ms 2025-10-02 10:18:03.274 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 261.000ms 2025-10-02 10:18:03.274 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 261.000ms 2025-10-02 10:18:03.274 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 262.000ms 2025-10-02 10:18:03.275 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 660.000ms 2025-10-02 10:18:03.673 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 802.000ms 2025-10-02 10:18:03.815 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node3 893.000ms 2025-10-02 10:18:03.906 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 1.026s 2025-10-02 10:18:04.039 3 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 1.033s 2025-10-02 10:18:04.046 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 1.062s 2025-10-02 10:18:04.075 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.064s 2025-10-02 10:18:04.077 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.065s 2025-10-02 10:18:04.078 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.065s 2025-10-02 10:18:04.078 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.066s 2025-10-02 10:18:04.079 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.066s 2025-10-02 10:18:04.079 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.066s 2025-10-02 10:18:04.079 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.067s 2025-10-02 10:18:04.080 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.068s 2025-10-02 10:18:04.081 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.068s 2025-10-02 10:18:04.081 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.068s 2025-10-02 10:18:04.081 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.069s 2025-10-02 10:18:04.082 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.069s 2025-10-02 10:18:04.082 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.069s 2025-10-02 10:18:04.082 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.070s 2025-10-02 10:18:04.083 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 1.182s 2025-10-02 10:18:04.195 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 1.279s 2025-10-02 10:18:04.292 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 1.334s 2025-10-02 10:18:04.347 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 1.422s 2025-10-02 10:18:04.435 3 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node1 1.424s 2025-10-02 10:18:04.437 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 1.429s 2025-10-02 10:18:04.442 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 1.460s 2025-10-02 10:18:04.473 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.462s 2025-10-02 10:18:04.475 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.462s 2025-10-02 10:18:04.475 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.463s 2025-10-02 10:18:04.476 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.464s 2025-10-02 10:18:04.477 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.464s 2025-10-02 10:18:04.477 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.465s 2025-10-02 10:18:04.478 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.466s 2025-10-02 10:18:04.479 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.466s 2025-10-02 10:18:04.479 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.467s 2025-10-02 10:18:04.480 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.467s 2025-10-02 10:18:04.480 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.467s 2025-10-02 10:18:04.480 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.468s 2025-10-02 10:18:04.481 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.469s 2025-10-02 10:18:04.482 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.469s 2025-10-02 10:18:04.482 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node3 1.481s 2025-10-02 10:18:04.494 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 1.539s 2025-10-02 10:18:04.552 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 878ms
node1 1.555s 2025-10-02 10:18:04.568 3 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node1 1.561s 2025-10-02 10:18:04.574 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 1.587s 2025-10-02 10:18:04.600 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 1.591s 2025-10-02 10:18:04.604 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 1.600s 2025-10-02 10:18:04.613 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.604s 2025-10-02 10:18:04.617 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.607s 2025-10-02 10:18:04.620 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.609s 2025-10-02 10:18:04.622 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.611s 2025-10-02 10:18:04.624 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.611s 2025-10-02 10:18:04.624 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.613s 2025-10-02 10:18:04.626 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 1.614s 2025-10-02 10:18:04.627 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.614s 2025-10-02 10:18:04.627 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.615s 2025-10-02 10:18:04.628 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.615s 2025-10-02 10:18:04.628 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.616s 2025-10-02 10:18:04.629 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.616s 2025-10-02 10:18:04.629 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.616s 2025-10-02 10:18:04.629 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 1.644s 2025-10-02 10:18:04.657 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 1.644s 2025-10-02 10:18:04.657 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 1.926s 2025-10-02 10:18:04.939 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node1 2.112s 2025-10-02 10:18:05.125 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 2.379s 2025-10-02 10:18:05.392 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 897ms
node3 2.428s 2025-10-02 10:18:05.441 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 2.490s 2025-10-02 10:18:05.503 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 2.491s 2025-10-02 10:18:05.504 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 2.848s 2025-10-02 10:18:05.861 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 921ms
node0 2.910s 2025-10-02 10:18:05.923 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 2.969s 2025-10-02 10:18:05.982 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 2.970s 2025-10-02 10:18:05.983 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 3.211s 2025-10-02 10:18:06.224 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1099ms
node1 3.260s 2025-10-02 10:18:06.273 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 3.328s 2025-10-02 10:18:06.341 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 3.329s 2025-10-02 10:18:06.342 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node2 3.613s 2025-10-02 10:18:06.626 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 3.699s 2025-10-02 10:18:06.712 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 3.700s 2025-10-02 10:18:06.713 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 3.700s 2025-10-02 10:18:06.713 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 3.700s 2025-10-02 10:18:06.713 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 3.700s 2025-10-02 10:18:06.713 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 3.701s 2025-10-02 10:18:06.714 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 3.701s 2025-10-02 10:18:06.714 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 3.701s 2025-10-02 10:18:06.714 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 3.705s 2025-10-02 10:18:06.718 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 3.708s 2025-10-02 10:18:06.721 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 3.709s 2025-10-02 10:18:06.722 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node2 4.405s 2025-10-02 10:18:07.418 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.406s 2025-10-02 10:18:07.419 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 4.465s 2025-10-02 10:18:07.478 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node2 4.469s 2025-10-02 10:18:07.482 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.470s 2025-10-02 10:18:07.483 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 4.470s 2025-10-02 10:18:07.483 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node3 4.512s 2025-10-02 10:18:07.525 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 4.515s 2025-10-02 10:18:07.528 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 4.520s 2025-10-02 10:18:07.533 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 4.596s 2025-10-02 10:18:07.609 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 4.597s 2025-10-02 10:18:07.610 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 4.597s 2025-10-02 10:18:07.610 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 4.597s 2025-10-02 10:18:07.610 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 4.597s 2025-10-02 10:18:07.610 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 4.598s 2025-10-02 10:18:07.611 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 4.598s 2025-10-02 10:18:07.611 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 4.598s 2025-10-02 10:18:07.611 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 4.601s 2025-10-02 10:18:07.614 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 4.605s 2025-10-02 10:18:07.618 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 4.605s 2025-10-02 10:18:07.618 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node0 4.991s 2025-10-02 10:18:08.004 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 5.070s 2025-10-02 10:18:08.083 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 5.071s 2025-10-02 10:18:08.084 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 5.071s 2025-10-02 10:18:08.084 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 5.072s 2025-10-02 10:18:08.085 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 5.072s 2025-10-02 10:18:08.085 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 5.072s 2025-10-02 10:18:08.085 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 5.072s 2025-10-02 10:18:08.085 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 5.073s 2025-10-02 10:18:08.086 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 5.076s 2025-10-02 10:18:08.089 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.079s 2025-10-02 10:18:08.092 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 5.080s 2025-10-02 10:18:08.093 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node3 5.331s 2025-10-02 10:18:08.344 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.331s 2025-10-02 10:18:08.344 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 5.341s 2025-10-02 10:18:08.354 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 5.383s 2025-10-02 10:18:08.396 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node3 5.390s 2025-10-02 10:18:08.403 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.390s 2025-10-02 10:18:08.403 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 5.391s 2025-10-02 10:18:08.404 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node1 5.422s 2025-10-02 10:18:08.435 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 5.422s 2025-10-02 10:18:08.435 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 5.423s 2025-10-02 10:18:08.436 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 5.423s 2025-10-02 10:18:08.436 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 5.423s 2025-10-02 10:18:08.436 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 5.424s 2025-10-02 10:18:08.437 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 5.424s 2025-10-02 10:18:08.437 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 5.424s 2025-10-02 10:18:08.437 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 5.427s 2025-10-02 10:18:08.440 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.431s 2025-10-02 10:18:08.444 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 5.431s 2025-10-02 10:18:08.444 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node3 5.449s 2025-10-02 10:18:08.462 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node3 5.456s 2025-10-02 10:18:08.469 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 5.637s 2025-10-02 10:18:08.650 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26302842] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=138770, randomLong=-6475583637987064330, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=8820, randomLong=-7073270187453217230, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=905190, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms)
node2 5.668s 2025-10-02 10:18:08.681 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node2 5.675s 2025-10-02 10:18:08.688 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 5.680s 2025-10-02 10:18:08.693 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 5.761s 2025-10-02 10:18:08.774 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IimHYQ==", "port": 30124 }, { "ipAddressV4": "CoAAXQ==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Ij9giA==", "port": 30125 }, { "ipAddressV4": "CoAAWw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IjzUZg==", "port": 30126 }, { "ipAddressV4": "CoAAWg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "IkLmMQ==", "port": 30127 }, { "ipAddressV4": "CoAAXA==", "port": 30127 }] }] }
node0 5.765s 2025-10-02 10:18:08.778 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.765s 2025-10-02 10:18:08.778 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 5.819s 2025-10-02 10:18:08.832 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node0 5.825s 2025-10-02 10:18:08.838 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.825s 2025-10-02 10:18:08.838 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 5.826s 2025-10-02 10:18:08.839 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node2 5.856s 2025-10-02 10:18:08.869 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 5.856s 2025-10-02 10:18:08.869 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 5.859s 2025-10-02 10:18:08.872 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.859s 2025-10-02 10:18:08.872 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 5.859s 2025-10-02 10:18:08.872 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node2 5.862s 2025-10-02 10:18:08.875 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.863s 2025-10-02 10:18:08.876 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.863s 2025-10-02 10:18:08.876 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node2 5.865s 2025-10-02 10:18:08.878 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.865s 2025-10-02 10:18:08.878 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.865s 2025-10-02 10:18:08.878 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node0 5.873s 2025-10-02 10:18:08.886 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 5.879s 2025-10-02 10:18:08.892 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 5.879s 2025-10-02 10:18:08.892 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 41f923ae75576f8d714dc47dfc16734f51b2d79fe84f9247d2c857186f0179282aea3cd3f7f69a3cb8995e5b8f7b5972 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / dish-into-priority-vast 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 6.071s 2025-10-02 10:18:09.084 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 6.076s 2025-10-02 10:18:09.089 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 6.085s 2025-10-02 10:18:09.098 138 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 6.085s 2025-10-02 10:18:09.098 139 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 6.088s 2025-10-02 10:18:09.101 140 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 6.088s 2025-10-02 10:18:09.101 141 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 6.088s 2025-10-02 10:18:09.101 142 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 6.089s 2025-10-02 10:18:09.102 143 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 6.089s 2025-10-02 10:18:09.102 144 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 6.089s 2025-10-02 10:18:09.102 145 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 6.089s 2025-10-02 10:18:09.102 146 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 6.089s 2025-10-02 10:18:09.102 147 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 6.090s 2025-10-02 10:18:09.103 148 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 6.090s 2025-10-02 10:18:09.103 149 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 6.090s 2025-10-02 10:18:09.103 150 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 6.090s 2025-10-02 10:18:09.103 151 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 6.090s 2025-10-02 10:18:09.103 152 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node2 6.108s 2025-10-02 10:18:09.121 153 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 6.108s 2025-10-02 10:18:09.121 154 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 6.109s 2025-10-02 10:18:09.122 155 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 6.109s 2025-10-02 10:18:09.122 156 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 6.109s 2025-10-02 10:18:09.122 157 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 6.110s 2025-10-02 10:18:09.123 158 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node2 6.110s 2025-10-02 10:18:09.123 159 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 6.111s 2025-10-02 10:18:09.124 160 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node2 6.117s 2025-10-02 10:18:09.130 161 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@55aaeac1
node2 6.118s 2025-10-02 10:18:09.131 162 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 80000
node2 6.118s 2025-10-02 10:18:09.131 163 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node2 6.125s 2025-10-02 10:18:09.138 168 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@5ad34869, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@432b20b5,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@64dfbaf1,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6fcd1bd,snapshotInProgress=false]
node2 6.134s 2025-10-02 10:18:09.147 169 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 6.134s 2025-10-02 10:18:09.147 170 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 6.139s 2025-10-02 10:18:09.152 171 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is 5095026561343202480
node2 6.139s 2025-10-02 10:18:09.152 172 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 6.159s 2025-10-02 10:18:09.172 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 6.160s 2025-10-02 10:18:09.173 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.218s 2025-10-02 10:18:09.231 173 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node1 6.219s 2025-10-02 10:18:09.232 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node2 6.219s 2025-10-02 10:18:09.232 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 6.223s 2025-10-02 10:18:09.236 175 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 6.224s 2025-10-02 10:18:09.237 176 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 6.224s 2025-10-02 10:18:09.237 177 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node1 6.225s 2025-10-02 10:18:09.238 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 6.226s 2025-10-02 10:18:09.239 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.226s 2025-10-02 10:18:09.239 178 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node1 6.227s 2025-10-02 10:18:09.240 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node2 6.227s 2025-10-02 10:18:09.240 179 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 6.228s 2025-10-02 10:18:09.241 180 INFO STARTUP <<start-node-2>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node2 6.229s 2025-10-02 10:18:09.242 181 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 299.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 6.229s 2025-10-02 10:18:09.242 182 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 6.232s 2025-10-02 10:18:09.245 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 6.233s 2025-10-02 10:18:09.246 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 6.233s 2025-10-02 10:18:09.246 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 6.277s 2025-10-02 10:18:09.290 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 6.282s 2025-10-02 10:18:09.295 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 6.583s 2025-10-02 10:18:09.596 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26309738] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=802510, randomLong=-500053810077173109, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=8370, randomLong=-7076372162865402748, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1268200, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms)
node3 6.612s 2025-10-02 10:18:09.625 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 6.619s 2025-10-02 10:18:09.632 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 6.624s 2025-10-02 10:18:09.637 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 6.706s 2025-10-02 10:18:09.719 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IimHYQ==", "port": 30124 }, { "ipAddressV4": "CoAAXQ==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Ij9giA==", "port": 30125 }, { "ipAddressV4": "CoAAWw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IjzUZg==", "port": 30126 }, { "ipAddressV4": "CoAAWg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "IkLmMQ==", "port": 30127 }, { "ipAddressV4": "CoAAXA==", "port": 30127 }] }] }
node3 6.802s 2025-10-02 10:18:09.815 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 6.803s 2025-10-02 10:18:09.816 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 6.805s 2025-10-02 10:18:09.818 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.805s 2025-10-02 10:18:09.818 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 6.806s 2025-10-02 10:18:09.819 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node3 6.809s 2025-10-02 10:18:09.822 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.809s 2025-10-02 10:18:09.822 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 6.809s 2025-10-02 10:18:09.822 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node3 6.811s 2025-10-02 10:18:09.824 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.811s 2025-10-02 10:18:09.824 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 6.811s 2025-10-02 10:18:09.824 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node3 6.826s 2025-10-02 10:18:09.839 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 41f923ae75576f8d714dc47dfc16734f51b2d79fe84f9247d2c857186f0179282aea3cd3f7f69a3cb8995e5b8f7b5972 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / dish-into-priority-vast 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 6.999s 2025-10-02 10:18:10.012 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26123920] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=186120, randomLong=5383969941746191062, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=15620, randomLong=-7416497775389295530, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=969230, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms)
node0 7.028s 2025-10-02 10:18:10.041 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 7.030s 2025-10-02 10:18:10.043 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 7.034s 2025-10-02 10:18:10.047 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 7.035s 2025-10-02 10:18:10.048 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 7.040s 2025-10-02 10:18:10.053 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 7.044s 2025-10-02 10:18:10.057 138 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 7.045s 2025-10-02 10:18:10.058 139 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 7.047s 2025-10-02 10:18:10.060 140 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 7.048s 2025-10-02 10:18:10.061 141 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 7.048s 2025-10-02 10:18:10.061 142 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 7.048s 2025-10-02 10:18:10.061 143 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 7.048s 2025-10-02 10:18:10.061 144 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 7.048s 2025-10-02 10:18:10.061 145 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 7.049s 2025-10-02 10:18:10.062 146 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 7.049s 2025-10-02 10:18:10.062 147 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 7.049s 2025-10-02 10:18:10.062 148 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 7.049s 2025-10-02 10:18:10.062 149 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 7.049s 2025-10-02 10:18:10.062 150 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 7.049s 2025-10-02 10:18:10.062 151 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 7.050s 2025-10-02 10:18:10.063 152 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node3 7.066s 2025-10-02 10:18:10.079 153 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 7.066s 2025-10-02 10:18:10.079 154 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 7.066s 2025-10-02 10:18:10.079 155 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 7.067s 2025-10-02 10:18:10.080 156 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 7.067s 2025-10-02 10:18:10.080 157 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 7.067s 2025-10-02 10:18:10.080 158 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node3 7.068s 2025-10-02 10:18:10.081 159 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 7.070s 2025-10-02 10:18:10.083 160 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node3 7.075s 2025-10-02 10:18:10.088 161 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@6d5b0ae4
node3 7.076s 2025-10-02 10:18:10.089 162 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 80000
node3 7.076s 2025-10-02 10:18:10.089 163 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node3 7.083s 2025-10-02 10:18:10.096 168 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@50049f5e, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@216c89d4,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@6333a468,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1481e71f,snapshotInProgress=false]
node3 7.091s 2025-10-02 10:18:10.104 169 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 7.091s 2025-10-02 10:18:10.104 170 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 7.095s 2025-10-02 10:18:10.108 171 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is 4639311454177307429
node3 7.096s 2025-10-02 10:18:10.109 172 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 7.124s 2025-10-02 10:18:10.137 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IimHYQ==", "port": 30124 }, { "ipAddressV4": "CoAAXQ==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Ij9giA==", "port": 30125 }, { "ipAddressV4": "CoAAWw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IjzUZg==", "port": 30126 }, { "ipAddressV4": "CoAAWg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "IkLmMQ==", "port": 30127 }, { "ipAddressV4": "CoAAXA==", "port": 30127 }] }] }
node3 7.178s 2025-10-02 10:18:10.191 173 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 7.180s 2025-10-02 10:18:10.193 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 7.185s 2025-10-02 10:18:10.198 175 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 7.187s 2025-10-02 10:18:10.200 176 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 7.187s 2025-10-02 10:18:10.200 177 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 7.189s 2025-10-02 10:18:10.202 178 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 7.190s 2025-10-02 10:18:10.203 179 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 7.191s 2025-10-02 10:18:10.204 180 INFO STARTUP <<start-node-3>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node3 7.192s 2025-10-02 10:18:10.205 181 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 313.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 7.192s 2025-10-02 10:18:10.205 182 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 7.196s 2025-10-02 10:18:10.209 183 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 7.196s 2025-10-02 10:18:10.209 184 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 7.197s 2025-10-02 10:18:10.210 185 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 7.220s 2025-10-02 10:18:10.233 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 7.220s 2025-10-02 10:18:10.233 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 7.223s 2025-10-02 10:18:10.236 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 7.223s 2025-10-02 10:18:10.236 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 7.223s 2025-10-02 10:18:10.236 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node0 7.227s 2025-10-02 10:18:10.240 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 7.227s 2025-10-02 10:18:10.240 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 7.227s 2025-10-02 10:18:10.240 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node0 7.229s 2025-10-02 10:18:10.242 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 7.229s 2025-10-02 10:18:10.242 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 7.230s 2025-10-02 10:18:10.243 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node0 7.244s 2025-10-02 10:18:10.257 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 41f923ae75576f8d714dc47dfc16734f51b2d79fe84f9247d2c857186f0179282aea3cd3f7f69a3cb8995e5b8f7b5972 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / dish-into-priority-vast 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 7.416s 2025-10-02 10:18:10.429 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26302986] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=232020, randomLong=4608496278024380726, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9610, randomLong=5004964362492420209, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1200349, data=35, exception=null] OS Health Check Report - Complete (took 1024 ms)
node0 7.439s 2025-10-02 10:18:10.452 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 7.444s 2025-10-02 10:18:10.457 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 7.448s 2025-10-02 10:18:10.461 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 7.453s 2025-10-02 10:18:10.466 138 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 7.454s 2025-10-02 10:18:10.467 139 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 7.455s 2025-10-02 10:18:10.468 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 7.457s 2025-10-02 10:18:10.470 140 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 7.458s 2025-10-02 10:18:10.471 141 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 7.458s 2025-10-02 10:18:10.471 142 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 7.458s 2025-10-02 10:18:10.471 143 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 7.459s 2025-10-02 10:18:10.472 144 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 7.459s 2025-10-02 10:18:10.472 145 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 7.459s 2025-10-02 10:18:10.472 146 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 7.459s 2025-10-02 10:18:10.472 147 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 7.459s 2025-10-02 10:18:10.472 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 7.460s 2025-10-02 10:18:10.473 148 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 7.460s 2025-10-02 10:18:10.473 149 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 7.460s 2025-10-02 10:18:10.473 150 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 7.461s 2025-10-02 10:18:10.474 151 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 7.461s 2025-10-02 10:18:10.474 152 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 7.481s 2025-10-02 10:18:10.494 153 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 7.481s 2025-10-02 10:18:10.494 154 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 7.482s 2025-10-02 10:18:10.495 155 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 7.482s 2025-10-02 10:18:10.495 156 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 7.483s 2025-10-02 10:18:10.496 157 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 7.483s 2025-10-02 10:18:10.496 158 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node0 7.483s 2025-10-02 10:18:10.496 159 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 7.485s 2025-10-02 10:18:10.498 160 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node0 7.492s 2025-10-02 10:18:10.505 161 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@4be8dad6
node0 7.493s 2025-10-02 10:18:10.506 162 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 80000
node0 7.493s 2025-10-02 10:18:10.506 163 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node0 7.502s 2025-10-02 10:18:10.515 168 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@5f3b1e0b, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@459807c1,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@68ddda55,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@71a7682b,snapshotInProgress=false]
node0 7.512s 2025-10-02 10:18:10.525 169 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 7.513s 2025-10-02 10:18:10.526 170 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 7.517s 2025-10-02 10:18:10.530 171 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is -686895759501151471
node0 7.518s 2025-10-02 10:18:10.531 172 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 7.538s 2025-10-02 10:18:10.551 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IimHYQ==", "port": 30124 }, { "ipAddressV4": "CoAAXQ==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Ij9giA==", "port": 30125 }, { "ipAddressV4": "CoAAWw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IjzUZg==", "port": 30126 }, { "ipAddressV4": "CoAAWg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "IkLmMQ==", "port": 30127 }, { "ipAddressV4": "CoAAXA==", "port": 30127 }] }] }
node0 7.603s 2025-10-02 10:18:10.616 173 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 7.605s 2025-10-02 10:18:10.618 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 7.609s 2025-10-02 10:18:10.622 175 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 7.610s 2025-10-02 10:18:10.623 176 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 7.611s 2025-10-02 10:18:10.624 177 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 7.612s 2025-10-02 10:18:10.625 178 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 7.612s 2025-10-02 10:18:10.625 179 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 7.614s 2025-10-02 10:18:10.627 180 INFO STARTUP <<start-node-0>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node0 7.615s 2025-10-02 10:18:10.628 181 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 7.615s 2025-10-02 10:18:10.628 182 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 318.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 7.619s 2025-10-02 10:18:10.632 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 7.620s 2025-10-02 10:18:10.633 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 7.620s 2025-10-02 10:18:10.633 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 7.636s 2025-10-02 10:18:10.649 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 7.636s 2025-10-02 10:18:10.649 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 7.638s 2025-10-02 10:18:10.651 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.639s 2025-10-02 10:18:10.652 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 7.639s 2025-10-02 10:18:10.652 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node1 7.642s 2025-10-02 10:18:10.655 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.642s 2025-10-02 10:18:10.655 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 7.642s 2025-10-02 10:18:10.655 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node1 7.644s 2025-10-02 10:18:10.657 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.644s 2025-10-02 10:18:10.657 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 7.645s 2025-10-02 10:18:10.658 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node1 7.660s 2025-10-02 10:18:10.673 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 41f923ae75576f8d714dc47dfc16734f51b2d79fe84f9247d2c857186f0179282aea3cd3f7f69a3cb8995e5b8f7b5972 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / dish-into-priority-vast 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 7.877s 2025-10-02 10:18:10.890 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 7.882s 2025-10-02 10:18:10.895 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 7.893s 2025-10-02 10:18:10.906 138 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 7.894s 2025-10-02 10:18:10.907 139 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 7.896s 2025-10-02 10:18:10.909 140 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 7.897s 2025-10-02 10:18:10.910 141 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 7.897s 2025-10-02 10:18:10.910 142 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 7.897s 2025-10-02 10:18:10.910 143 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 7.897s 2025-10-02 10:18:10.910 144 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 7.898s 2025-10-02 10:18:10.911 145 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 7.898s 2025-10-02 10:18:10.911 146 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 7.898s 2025-10-02 10:18:10.911 147 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 7.898s 2025-10-02 10:18:10.911 148 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 7.898s 2025-10-02 10:18:10.911 149 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 7.898s 2025-10-02 10:18:10.911 150 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 7.899s 2025-10-02 10:18:10.912 151 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 7.899s 2025-10-02 10:18:10.912 152 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node1 7.917s 2025-10-02 10:18:10.930 153 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 7.918s 2025-10-02 10:18:10.931 154 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 7.918s 2025-10-02 10:18:10.931 155 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 7.918s 2025-10-02 10:18:10.931 156 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 7.919s 2025-10-02 10:18:10.932 157 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 7.919s 2025-10-02 10:18:10.932 158 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node1 7.919s 2025-10-02 10:18:10.932 159 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 7.921s 2025-10-02 10:18:10.934 160 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node1 7.926s 2025-10-02 10:18:10.939 161 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@7b0e5998
node1 7.927s 2025-10-02 10:18:10.940 162 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 80000
node1 7.927s 2025-10-02 10:18:10.940 163 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node1 7.935s 2025-10-02 10:18:10.948 168 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@56d04c86, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@3a592403,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@28db7e9b,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@7d8c538b,snapshotInProgress=false]
node1 7.944s 2025-10-02 10:18:10.957 169 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 7.944s 2025-10-02 10:18:10.957 170 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 7.949s 2025-10-02 10:18:10.962 171 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is 3723657824940747892
node1 7.949s 2025-10-02 10:18:10.962 172 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 8.034s 2025-10-02 10:18:11.047 173 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 8.037s 2025-10-02 10:18:11.050 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 8.041s 2025-10-02 10:18:11.054 175 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 8.042s 2025-10-02 10:18:11.055 176 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 8.043s 2025-10-02 10:18:11.056 177 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 8.045s 2025-10-02 10:18:11.058 178 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 8.045s 2025-10-02 10:18:11.058 179 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 8.047s 2025-10-02 10:18:11.060 180 INFO STARTUP <<start-node-1>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node1 8.048s 2025-10-02 10:18:11.061 181 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 8.050s 2025-10-02 10:18:11.063 182 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 333.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 8.054s 2025-10-02 10:18:11.067 183 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 8.055s 2025-10-02 10:18:11.068 184 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 8.055s 2025-10-02 10:18:11.068 185 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 9.093s 2025-10-02 10:18:12.106 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 9.096s 2025-10-02 10:18:12.109 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 10.054s 2025-10-02 10:18:13.067 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ]
node3 10.057s 2025-10-02 10:18:13.070 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 10.461s 2025-10-02 10:18:13.474 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ]
node0 10.464s 2025-10-02 10:18:13.477 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 10.904s 2025-10-02 10:18:13.917 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting1.csv' ]
node1 10.907s 2025-10-02 10:18:13.920 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node2 16.324s 2025-10-02 10:18:19.337 188 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 16.325s 2025-10-02 10:18:19.338 189 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node3 17.289s 2025-10-02 10:18:20.302 188 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 17.291s 2025-10-02 10:18:20.304 189 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node0 17.712s 2025-10-02 10:18:20.725 188 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 17.713s 2025-10-02 10:18:20.726 189 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node1 18.144s 2025-10-02 10:18:21.157 188 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 18.145s 2025-10-02 10:18:21.158 189 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node2 19.109s 2025-10-02 10:18:22.122 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node2 19.109s 2025-10-02 10:18:22.122 191 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 2.8 s in CHECKING. Now in ACTIVE
node2 19.110s 2025-10-02 10:18:22.123 192 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 19.180s 2025-10-02 10:18:22.193 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node2 19.186s 2025-10-02 10:18:22.199 193 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x7F10922844F1D702D454378E63D6F9D9D5677D0963F4B5F9750D7B809EA1220F', privateKey ='0x7F10922844F1D702D454378E63D6F9D9D5677D0963F4B5F9750D7B809EA1220F', signature = '0x740992738D9B5CE97693E5B66889B97A78D62E0B3E79FC64D1CFC934AA08D4EBECE5F467421929B3D61236E9F5C7AD6DD7CCA8881F4F00D9D47164E41982F603',message = '0x12660A1E080210021880E2092080E2092880E2093080E20940E583A3A182A8F5974332420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003802' }
node3 19.196s 2025-10-02 10:18:22.209 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 19.279s 2025-10-02 10:18:22.292 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 19.794s 2025-10-02 10:18:22.807 191 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 1.6 s in CHECKING. Now in ACTIVE
node1 19.794s 2025-10-02 10:18:22.807 192 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 19.832s 2025-10-02 10:18:22.845 193 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x691F60D717E06E8479F772EF59B93BA244EBFDB6A376CBAA248CDC41B4915CAD', privateKey ='0x691F60D717E06E8479F772EF59B93BA244EBFDB6A376CBAA248CDC41B4915CAD', signature = '0x6DBB89F840AADE80E1066EC3F65B961E61556969FC10F7C3CB2CC813E0BCF3541A3AD627DEC83B13E79B9C577E346D15176E8E6AE1AECCDC3350D5750C357C0D',message = '0x12660A1E080110011880F1042080F1042880F1043080F1044083C1B4C8CFD487C41E32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003801' }
node0 19.851s 2025-10-02 10:18:22.864 191 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.1 s in CHECKING. Now in ACTIVE
node0 19.852s 2025-10-02 10:18:22.865 192 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 19.899s 2025-10-02 10:18:22.912 193 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x6F0E5106D6E1DCDED06A00513CD8E470DED57100DDCF23A6D72DD894C952F943', privateKey ='0x6F0E5106D6E1DCDED06A00513CD8E470DED57100DDCF23A6D72DD894C952F943', signature = '0x4263D54FF9515A017A1B6080A78A4B5AA4FC9E71DF092FCCEFD64AE01B3D95EA63D131B072C7C90ED2C14005EAF8A3A0F18E8CF15DD8B710E0456F234DE0250E',message = '0x12660A0A40DDD68AF8F9EC8D9F43325800000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' }
node3 19.928s 2025-10-02 10:18:22.941 191 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.6 s in CHECKING. Now in ACTIVE
node3 19.928s 2025-10-02 10:18:22.941 192 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 19.976s 2025-10-02 10:18:22.989 193 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x6BA12DEC5B75DCAD0DAE6A5D208917D0B41A0DB1CA1E729EA80F7C58A9F5EA38', privateKey ='0x6BA12DEC5B75DCAD0DAE6A5D208917D0B41A0DB1CA1E729EA80F7C58A9F5EA38', signature = '0x9A2FA239C9DED8A9FBB05C43D694F4C22D528E4BD2C059DA3C7F8D01F82EC6C4BB76761E5103971D497F5180879420E09BB053B712C3848F565D1B0436F5B702',message = '0x12660A1E080310031880D30E2080D30E2880D30E3080D30E40A4D4E0BCBBC2D0F80332420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003803' }
node1 20.935s 2025-10-02 10:18:23.948 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node2 21.089s 2025-10-02 10:18:24.102 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node0 21.145s 2025-10-02 10:18:24.158 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node3 21.216s 2025-10-02 10:18:24.229 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node1 21.606s 2025-10-02 10:18:24.619 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3
node1 21.608s 2025-10-02 10:18:24.621 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 21.675s 2025-10-02 10:18:24.688 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3
node0 21.677s 2025-10-02 10:18:24.690 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 21.751s 2025-10-02 10:18:24.764 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3
node3 21.753s 2025-10-02 10:18:24.766 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.861s 2025-10-02 10:18:24.874 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.864s 2025-10-02 10:18:24.877 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-02T10:18:22.201552Z Next consensus number: 18 Legacy running event hash: fe2ffaba94ca3774a21fc4464eb8629382ace227c2f747c49ec59a438a95919a0060617e79419568cbb4a28afb01a3fb Legacy running event mnemonic: demand-potato-grocery-update Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: f1040d91b8c98f1c4d8c845b08492767bca1ca6188e31fc63ec08f746b910ddaaa97ab06fe46a46f180ace5a6d26e635 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / test-rate-tragic-broken 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 seminar-benefit-universe-void 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 21.889s 2025-10-02 10:18:24.902 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3
node2 21.891s 2025-10-02 10:18:24.904 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.899s 2025-10-02 10:18:24.912 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+18+19.775762747Z_seq0_minr1_maxr501_orgn0.pces
node1 21.900s 2025-10-02 10:18:24.913 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+18+19.775762747Z_seq0_minr1_maxr501_orgn0.pces
node1 21.900s 2025-10-02 10:18:24.913 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 21.903s 2025-10-02 10:18:24.916 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 21.908s 2025-10-02 10:18:24.921 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 21.957s 2025-10-02 10:18:24.970 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 21.961s 2025-10-02 10:18:24.974 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-02T10:18:22.201552Z Next consensus number: 18 Legacy running event hash: fe2ffaba94ca3774a21fc4464eb8629382ace227c2f747c49ec59a438a95919a0060617e79419568cbb4a28afb01a3fb Legacy running event mnemonic: demand-potato-grocery-update Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: f1040d91b8c98f1c4d8c845b08492767bca1ca6188e31fc63ec08f746b910ddaaa97ab06fe46a46f180ace5a6d26e635 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / test-rate-tragic-broken 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 seminar-benefit-universe-void 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 21.997s 2025-10-02 10:18:25.010 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+18+19.738235285Z_seq0_minr1_maxr501_orgn0.pces
node0 21.999s 2025-10-02 10:18:25.012 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+18+19.738235285Z_seq0_minr1_maxr501_orgn0.pces
node0 21.999s 2025-10-02 10:18:25.012 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 22.002s 2025-10-02 10:18:25.015 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 22.007s 2025-10-02 10:18:25.020 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 22.014s 2025-10-02 10:18:25.027 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 22.017s 2025-10-02 10:18:25.030 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-02T10:18:22.201552Z Next consensus number: 18 Legacy running event hash: fe2ffaba94ca3774a21fc4464eb8629382ace227c2f747c49ec59a438a95919a0060617e79419568cbb4a28afb01a3fb Legacy running event mnemonic: demand-potato-grocery-update Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: f1040d91b8c98f1c4d8c845b08492767bca1ca6188e31fc63ec08f746b910ddaaa97ab06fe46a46f180ace5a6d26e635 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / test-rate-tragic-broken 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 seminar-benefit-universe-void 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 22.052s 2025-10-02 10:18:25.065 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+18+19.654299249Z_seq0_minr1_maxr501_orgn0.pces
node3 22.053s 2025-10-02 10:18:25.066 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+18+19.654299249Z_seq0_minr1_maxr501_orgn0.pces
node3 22.053s 2025-10-02 10:18:25.066 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 22.056s 2025-10-02 10:18:25.069 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 22.061s 2025-10-02 10:18:25.074 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 22.156s 2025-10-02 10:18:25.169 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node2 22.159s 2025-10-02 10:18:25.172 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-02T10:18:22.201552Z Next consensus number: 18 Legacy running event hash: fe2ffaba94ca3774a21fc4464eb8629382ace227c2f747c49ec59a438a95919a0060617e79419568cbb4a28afb01a3fb Legacy running event mnemonic: demand-potato-grocery-update Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: f1040d91b8c98f1c4d8c845b08492767bca1ca6188e31fc63ec08f746b910ddaaa97ab06fe46a46f180ace5a6d26e635 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / test-rate-tragic-broken 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 seminar-benefit-universe-void 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 22.191s 2025-10-02 10:18:25.204 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+18+19.373814613Z_seq0_minr1_maxr501_orgn0.pces
node2 22.192s 2025-10-02 10:18:25.205 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+18+19.373814613Z_seq0_minr1_maxr501_orgn0.pces
node2 22.192s 2025-10-02 10:18:25.205 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 22.195s 2025-10-02 10:18:25.208 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 22.199s 2025-10-02 10:18:25.212 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 1m 39.216s 2025-10-02 10:19:42.229 734 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 39.830s 2025-10-02 10:19:42.843 742 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 39.909s 2025-10-02 10:19:42.922 742 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 1m 40.007s 2025-10-02 10:19:43.020 742 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 6m 59.221s 2025-10-02 10:25:02.234 2691 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 6m 59.223s 2025-10-02 10:25:02.236 2692 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 6m 59.226s 2025-10-02 10:25:02.239 2693 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 6m 59.227s 2025-10-02 10:25:02.240 2694 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node1 6m 59.854s 2025-10-02 10:25:02.867 2699 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 6m 59.856s 2025-10-02 10:25:02.869 2700 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 6m 59.857s 2025-10-02 10:25:02.870 2701 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 6m 59.857s 2025-10-02 10:25:02.870 2702 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node0 6m 59.941s 2025-10-02 10:25:02.954 2691 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 6m 59.944s 2025-10-02 10:25:02.957 2692 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 6m 59.945s 2025-10-02 10:25:02.958 2693 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 6m 59.945s 2025-10-02 10:25:02.958 2694 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node3 6m 59.982s 2025-10-02 10:25:02.995 2699 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 6m 59.984s 2025-10-02 10:25:02.997 2700 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 6m 59.985s 2025-10-02 10:25:02.998 2701 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 6m 59.985s 2025-10-02 10:25:02.998 2702 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node1 7m 1.105s 2025-10-02 10:25:04.118 2703 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:02.665355Z ]
node1 7m 1.106s 2025-10-02 10:25:04.119 2704 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:02.665355Z,type=ENTER_VALIDATION]
node3 7m 1.198s 2025-10-02 10:25:04.211 2703 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:02.665355Z ]
node3 7m 1.199s 2025-10-02 10:25:04.212 2704 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:02.665355Z,type=ENTER_VALIDATION]
node2 7m 1.320s 2025-10-02 10:25:04.333 2703 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:02.665355Z ]
node2 7m 1.320s 2025-10-02 10:25:04.333 2704 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:02.665355Z,type=ENTER_VALIDATION]
node0 7m 1.490s 2025-10-02 10:25:04.503 2703 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:02.665355Z ]
node0 7m 1.491s 2025-10-02 10:25:04.504 2704 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:02.665355Z,type=ENTER_VALIDATION]
node0 7m 1.500s 2025-10-02 10:25:04.513 2709 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.217945586Z ]
node0 7m 1.501s 2025-10-02 10:25:04.514 2710 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:03.217945586Z,type=ENTER_VALIDATION]
node0 7m 1.502s 2025-10-02 10:25:04.515 2711 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.414834616Z ]
node0 7m 1.502s 2025-10-02 10:25:04.515 2712 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:03.414834616Z,type=ENTER_VALIDATION]
node1 7m 1.533s 2025-10-02 10:25:04.546 2709 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.217945586Z ]
node1 7m 1.534s 2025-10-02 10:25:04.547 2710 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:03.217945586Z,type=ENTER_VALIDATION]
node1 7m 1.535s 2025-10-02 10:25:04.548 2711 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.414834616Z ]
node1 7m 1.535s 2025-10-02 10:25:04.548 2712 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:03.414834616Z,type=ENTER_VALIDATION]
node3 7m 1.621s 2025-10-02 10:25:04.634 2709 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.217945586Z ]
node3 7m 1.622s 2025-10-02 10:25:04.635 2710 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:03.217945586Z,type=ENTER_VALIDATION]
node3 7m 1.623s 2025-10-02 10:25:04.636 2711 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.414834616Z ]
node3 7m 1.623s 2025-10-02 10:25:04.636 2712 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:03.414834616Z,type=ENTER_VALIDATION]
node2 7m 1.743s 2025-10-02 10:25:04.756 2717 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.217945586Z ]
node2 7m 1.743s 2025-10-02 10:25:04.756 2718 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:03.217945586Z,type=ENTER_VALIDATION]
node2 7m 1.744s 2025-10-02 10:25:04.757 2719 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.414834616Z ]
node2 7m 1.744s 2025-10-02 10:25:04.757 2720 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:03.414834616Z,type=ENTER_VALIDATION]
node1 7m 2.010s 2025-10-02 10:25:05.023 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.446706637Z ]
node1 7m 2.010s 2025-10-02 10:25:05.023 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:03.446706637Z,type=ENTER_VALIDATION]
node1 7m 2.012s 2025-10-02 10:25:05.025 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node1 7m 2.016s 2025-10-02 10:25:05.029 2724 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node1 7m 2.017s 2025-10-02 10:25:05.030 2725 INFO DEMO_INFO <<PTT: enter-validator 1>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node1 7m 2.018s 2025-10-02 10:25:05.031 2726 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1759400703446_446706637.json.gz
node1 7m 2.023s 2025-10-02 10:25:05.036 2727 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node1 7m 2.023s 2025-10-02 10:25:05.036 2728 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:03.446706637Z ]
node3 7m 2.055s 2025-10-02 10:25:05.068 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.446706637Z ]
node3 7m 2.055s 2025-10-02 10:25:05.068 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:03.446706637Z,type=ENTER_VALIDATION]
node3 7m 2.056s 2025-10-02 10:25:05.069 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node3 7m 2.061s 2025-10-02 10:25:05.074 2724 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node3 7m 2.062s 2025-10-02 10:25:05.075 2725 INFO DEMO_INFO <<PTT: enter-validator 3>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node3 7m 2.062s 2025-10-02 10:25:05.075 2726 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1759400703446_446706637.json.gz
node3 7m 2.069s 2025-10-02 10:25:05.082 2727 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node3 7m 2.069s 2025-10-02 10:25:05.082 2728 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:03.446706637Z ]
node2 7m 2.130s 2025-10-02 10:25:05.143 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.446706637Z ]
node2 7m 2.130s 2025-10-02 10:25:05.143 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:03.446706637Z,type=ENTER_VALIDATION]
node2 7m 2.131s 2025-10-02 10:25:05.144 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node2 7m 2.135s 2025-10-02 10:25:05.148 2724 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node2 7m 2.136s 2025-10-02 10:25:05.149 2725 INFO DEMO_INFO <<PTT: enter-validator 2>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node2 7m 2.136s 2025-10-02 10:25:05.149 2726 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1759400703446_446706637.json.gz
node2 7m 2.141s 2025-10-02 10:25:05.154 2727 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node2 7m 2.141s 2025-10-02 10:25:05.154 2728 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:03.446706637Z ]
node0 7m 2.235s 2025-10-02 10:25:05.248 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-02T10:25:03.446706637Z ]
node0 7m 2.236s 2025-10-02 10:25:05.249 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:03.446706637Z,type=ENTER_VALIDATION]
node0 7m 2.237s 2025-10-02 10:25:05.250 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node0 7m 2.242s 2025-10-02 10:25:05.255 2724 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node0 7m 2.243s 2025-10-02 10:25:05.256 2725 INFO DEMO_INFO <<PTT: enter-validator 0>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node0 7m 2.243s 2025-10-02 10:25:05.256 2726 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1759400703446_446706637.json.gz
node0 7m 2.250s 2025-10-02 10:25:05.263 2727 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1759400703446_446706637.json, consensusTime = 2025-10-02T10:25:03.446706637Z ]
node0 7m 2.250s 2025-10-02 10:25:05.263 2728 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:03.446706637Z ]
node1 7m 3.921s 2025-10-02 10:25:06.934 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.567370Z ]
node1 7m 3.921s 2025-10-02 10:25:06.934 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:05.567370Z,type=EXIT_VALIDATION]
node1 7m 3.921s 2025-10-02 10:25:06.934 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.601674Z ]
node1 7m 3.921s 2025-10-02 10:25:06.934 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:05.601674Z,type=EXIT_VALIDATION]
node1 7m 3.922s 2025-10-02 10:25:06.935 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.674787200Z ]
node1 7m 3.922s 2025-10-02 10:25:06.935 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:05.674787200Z,type=EXIT_VALIDATION]
node3 7m 4.031s 2025-10-02 10:25:07.044 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.567370Z ]
node3 7m 4.031s 2025-10-02 10:25:07.044 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:05.567370Z,type=EXIT_VALIDATION]
node3 7m 4.032s 2025-10-02 10:25:07.045 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.601674Z ]
node3 7m 4.032s 2025-10-02 10:25:07.045 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:05.601674Z,type=EXIT_VALIDATION]
node3 7m 4.032s 2025-10-02 10:25:07.045 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.674787200Z ]
node3 7m 4.032s 2025-10-02 10:25:07.045 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:05.674787200Z,type=EXIT_VALIDATION]
node2 7m 4.152s 2025-10-02 10:25:07.165 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.567370Z ]
node2 7m 4.152s 2025-10-02 10:25:07.165 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:05.567370Z,type=EXIT_VALIDATION]
node2 7m 4.152s 2025-10-02 10:25:07.165 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.601674Z ]
node2 7m 4.153s 2025-10-02 10:25:07.166 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:05.601674Z,type=EXIT_VALIDATION]
node2 7m 4.153s 2025-10-02 10:25:07.166 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.674787200Z ]
node2 7m 4.153s 2025-10-02 10:25:07.166 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:05.674787200Z,type=EXIT_VALIDATION]
node0 7m 4.320s 2025-10-02 10:25:07.333 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.567370Z ]
node0 7m 4.320s 2025-10-02 10:25:07.333 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-02T10:25:05.567370Z,type=EXIT_VALIDATION]
node0 7m 4.320s 2025-10-02 10:25:07.333 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.601674Z ]
node0 7m 4.320s 2025-10-02 10:25:07.333 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-02T10:25:05.601674Z,type=EXIT_VALIDATION]
node0 7m 4.321s 2025-10-02 10:25:07.334 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.674787200Z ]
node0 7m 4.321s 2025-10-02 10:25:07.334 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-02T10:25:05.674787200Z,type=EXIT_VALIDATION]
node0 7m 4.328s 2025-10-02 10:25:07.341 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.924929Z ]
node0 7m 4.328s 2025-10-02 10:25:07.341 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:05.924929Z,type=EXIT_VALIDATION]
node0 7m 4.329s 2025-10-02 10:25:07.342 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-02T10:25:05.924929Z ]
node0 7m 4.329s 2025-10-02 10:25:07.342 2751 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:05.924929Z ]
node0 7m 4.331s 2025-10-02 10:25:07.344 2755 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 7m 4.331s 2025-10-02 10:25:07.344 2756 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 7m 4.331s 2025-10-02 10:25:07.344 2757 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Waiting for final state to save before terminating
node1 7m 4.350s 2025-10-02 10:25:07.363 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.924929Z ]
node1 7m 4.351s 2025-10-02 10:25:07.364 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:05.924929Z,type=EXIT_VALIDATION]
node1 7m 4.351s 2025-10-02 10:25:07.364 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-02T10:25:05.924929Z ]
node1 7m 4.352s 2025-10-02 10:25:07.365 2751 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:05.924929Z ]
node1 7m 4.352s 2025-10-02 10:25:07.365 2753 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Waiting for final state to save before terminating
node3 7m 4.457s 2025-10-02 10:25:07.470 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.924929Z ]
node3 7m 4.457s 2025-10-02 10:25:07.470 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:05.924929Z,type=EXIT_VALIDATION]
node3 7m 4.458s 2025-10-02 10:25:07.471 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-02T10:25:05.924929Z ]
node3 7m 4.458s 2025-10-02 10:25:07.471 2751 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:05.924929Z ]
node3 7m 4.459s 2025-10-02 10:25:07.472 2753 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 4.578s 2025-10-02 10:25:07.591 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-02T10:25:05.924929Z ]
node2 7m 4.578s 2025-10-02 10:25:07.591 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-02T10:25:05.924929Z,type=EXIT_VALIDATION]
node2 7m 4.578s 2025-10-02 10:25:07.591 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-02T10:25:05.924929Z ]
node2 7m 4.579s 2025-10-02 10:25:07.592 2751 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-02T10:25:05.924929Z ]
node2 7m 4.579s 2025-10-02 10:25:07.592 2753 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 6.084s 2025-10-02 10:25:09.097 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759400767
node0 7m 6.130s 2025-10-02 10:25:09.143 2766 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759400767
3139 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-02T10:26:07.467296Z
node1 7m 6.244s 2025-10-02 10:25:09.257 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759400767
node3 7m 6.385s 2025-10-02 10:25:09.398 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759400767
node3 8m 5.595s 2025-10-02 10:26:08.608 3137 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 715 consensusTimeStamp: 2025-10-02T10:26:07.467296Z
node3 8m 5.596s 2025-10-02 10:26:08.609 3138 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-02T10:26:07.467296Z
node3 8m 5.597s 2025-10-02 10:26:08.610 3139 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node3 8m 5.597s 2025-10-02 10:26:08.610 3142 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: ENTERING FREEZING!
node3 8m 5.597s 2025-10-02 10:26:08.610 3143 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 715 created, will eventually be written to disk, for reason: FREEZE_STATE
node3 8m 5.598s 2025-10-02 10:26:08.611 3144 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node3 8m 5.598s 2025-10-02 10:26:08.611 3146 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZING
node3 8m 5.600s 2025-10-02 10:26:08.613 3147 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 715 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node3 8m 5.600s 2025-10-02 10:26:08.613 3148 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 715 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/715
node3 8m 5.601s 2025-10-02 10:26:08.614 3149 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node3 8m 5.626s 2025-10-02 10:26:08.639 3160 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 8m 5.638s 2025-10-02 10:26:08.651 3140 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 715 consensusTimeStamp: 2025-10-02T10:26:07.467296Z
node0 8m 5.639s 2025-10-02 10:26:08.652 3141 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node0 8m 5.639s 2025-10-02 10:26:08.652 3142 TRACE DEMO_INFO <platformForkJoinThread-5> PlatformTestingToolMain: ENTERING FREEZING!
node0 8m 5.640s 2025-10-02 10:26:08.653 3145 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 715 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 8m 5.640s 2025-10-02 10:26:08.653 3146 TRACE DEMO_INFO <platformForkJoinThread-5> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node0 8m 5.640s 2025-10-02 10:26:08.653 3147 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZING
node0 8m 5.641s 2025-10-02 10:26:08.654 3149 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 715 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node0 8m 5.642s 2025-10-02 10:26:08.655 3150 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 715 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/715
node0 8m 5.642s 2025-10-02 10:26:08.655 3151 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node0 8m 5.668s 2025-10-02 10:26:08.681 3163 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 5.710s 2025-10-02 10:26:08.723 3129 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 715 consensusTimeStamp: 2025-10-02T10:26:07.467296Z
node2 8m 5.711s 2025-10-02 10:26:08.724 3130 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-02T10:26:07.467296Z
node2 8m 5.711s 2025-10-02 10:26:08.724 3131 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node2 8m 5.711s 2025-10-02 10:26:08.724 3132 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: ENTERING FREEZING!
node2 8m 5.712s 2025-10-02 10:26:08.725 3135 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 715 created, will eventually be written to disk, for reason: FREEZE_STATE
node2 8m 5.712s 2025-10-02 10:26:08.725 3136 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node2 8m 5.712s 2025-10-02 10:26:08.725 3137 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZING
node2 8m 5.713s 2025-10-02 10:26:08.726 3139 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 715 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node2 8m 5.714s 2025-10-02 10:26:08.727 3140 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 715 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/715
node2 8m 5.714s 2025-10-02 10:26:08.727 3141 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node2 8m 5.740s 2025-10-02 10:26:08.753 3154 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node1 8m 5.769s 2025-10-02 10:26:08.782 3137 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 715 consensusTimeStamp: 2025-10-02T10:26:07.467296Z
node1 8m 5.770s 2025-10-02 10:26:08.783 3138 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-02T10:26:07.467296Z
node1 8m 5.772s 2025-10-02 10:26:08.785 3141 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 715 created, will eventually be written to disk, for reason: FREEZE_STATE
node1 8m 5.773s 2025-10-02 10:26:08.786 3142 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node1 8m 5.774s 2025-10-02 10:26:08.787 3144 TRACE DEMO_INFO <platformForkJoinThread-8> PlatformTestingToolMain: ENTERING FREEZING!
node1 8m 5.774s 2025-10-02 10:26:08.787 3145 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 715 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node1 8m 5.775s 2025-10-02 10:26:08.788 3146 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 715 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/715
node1 8m 5.776s 2025-10-02 10:26:08.789 3147 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node1 8m 5.776s 2025-10-02 10:26:08.789 3148 TRACE DEMO_INFO <platformForkJoinThread-8> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node1 8m 5.776s 2025-10-02 10:26:08.789 3149 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change FREEZING
node1 8m 5.800s 2025-10-02 10:26:08.813 3160 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 7.791s 2025-10-02 10:26:10.804 3211 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node2 8m 7.793s 2025-10-02 10:26:10.806 3212 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 715 Timestamp: 2025-10-02T10:26:07.467296Z Next consensus number: 12095 Legacy running event hash: a57d81efb9e754c9df7cb9c6dd91ff1b8ed1a29a154f60b6e7417060f315a1cbf2f81c3a8d2294d21c3bbb7884fdf05f Legacy running event mnemonic: expire-season-segment-odor Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1245816835 Root hash: 8d8d2c9ee747bffaa45652cadfac09eec304dd1ee7f056925e7c5e7c84e4a23b902640a5e24c308df842ce388f615749 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / example-need-blame-absorb 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 prize-topic-monitor-shield 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 purpose-expand-tennis-flower 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 8m 7.803s 2025-10-02 10:26:10.816 3213 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+19+28.631486060Z_seq10_minr74_maxr118_orgn0.pces Last file: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+21+42.061776032Z_seq21_minr283_maxr329_orgn0.pces
node2 8m 7.803s 2025-10-02 10:26:10.816 3214 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 688 First file to copy: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+25+38.664327292Z_seq39_minr641_maxr702_orgn0.pces Last file to copy: data/saved/preconsensus-events/2/2025/10/02/2025-10-02T10+26+00.801065335Z_seq40_minr675_maxr739_orgn0.pces
node2 8m 7.804s 2025-10-02 10:26:10.817 3215 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node2 8m 7.804s 2025-10-02 10:26:10.817 3216 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node2 8m 7.805s 2025-10-02 10:26:10.818 3217 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 715 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/715 {"round":715,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/715/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 8m 7.806s 2025-10-02 10:26:10.819 3218 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-02T10:26:07.467296Z ]
node2 8m 7.807s 2025-10-02 10:26:10.820 3219 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 2.1 s in FREEZING. Now in FREEZE_COMPLETE
node2 8m 7.807s 2025-10-02 10:26:10.820 3220 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-02T10:26:07.467296Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node2 8m 7.807s 2025-10-02 10:26:10.820 3221 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node3 8m 7.943s 2025-10-02 10:26:10.956 3211 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node3 8m 7.945s 2025-10-02 10:26:10.958 3212 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 715 Timestamp: 2025-10-02T10:26:07.467296Z Next consensus number: 12095 Legacy running event hash: a57d81efb9e754c9df7cb9c6dd91ff1b8ed1a29a154f60b6e7417060f315a1cbf2f81c3a8d2294d21c3bbb7884fdf05f Legacy running event mnemonic: expire-season-segment-odor Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1245816835 Root hash: 8d8d2c9ee747bffaa45652cadfac09eec304dd1ee7f056925e7c5e7c84e4a23b902640a5e24c308df842ce388f615749 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / example-need-blame-absorb 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 prize-topic-monitor-shield 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 purpose-expand-tennis-flower 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 8m 7.956s 2025-10-02 10:26:10.969 3213 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+18+35.543458717Z_seq1_minr1_maxr23_orgn0.pces Last file: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+20+52.265798848Z_seq17_minr206_maxr256_orgn0.pces
node3 8m 7.957s 2025-10-02 10:26:10.970 3214 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 688 First file to copy: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+25+35.758802786Z_seq39_minr637_maxr698_orgn0.pces Last file to copy: data/saved/preconsensus-events/3/2025/10/02/2025-10-02T10+25+58.885554335Z_seq40_minr671_maxr734_orgn0.pces
node3 8m 7.957s 2025-10-02 10:26:10.970 3215 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node3 8m 7.958s 2025-10-02 10:26:10.971 3216 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node3 8m 7.958s 2025-10-02 10:26:10.971 3217 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 715 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/715 {"round":715,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/715/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 8m 7.959s 2025-10-02 10:26:10.972 3218 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-02T10:26:07.467296Z ]
node3 8m 7.960s 2025-10-02 10:26:10.973 3219 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.4 s in FREEZING. Now in FREEZE_COMPLETE
node3 8m 7.960s 2025-10-02 10:26:10.973 3220 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node3 8m 7.961s 2025-10-02 10:26:10.974 3221 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-02T10:26:07.467296Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 8m 7.973s 2025-10-02 10:26:10.986 3213 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node0 8m 7.975s 2025-10-02 10:26:10.988 3214 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 715 Timestamp: 2025-10-02T10:26:07.467296Z Next consensus number: 12095 Legacy running event hash: a57d81efb9e754c9df7cb9c6dd91ff1b8ed1a29a154f60b6e7417060f315a1cbf2f81c3a8d2294d21c3bbb7884fdf05f Legacy running event mnemonic: expire-season-segment-odor Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1245816835 Root hash: 8d8d2c9ee747bffaa45652cadfac09eec304dd1ee7f056925e7c5e7c84e4a23b902640a5e24c308df842ce388f615749 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / example-need-blame-absorb 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 prize-topic-monitor-shield 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 purpose-expand-tennis-flower 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 8m 7.984s 2025-10-02 10:26:10.997 3215 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+19+09.519135296Z_seq8_minr43_maxr85_orgn0.pces Last file: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+22+09.729306528Z_seq23_minr325_maxr373_orgn0.pces
node0 8m 7.985s 2025-10-02 10:26:10.998 3216 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 688 First file to copy: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+25+41.389077589Z_seq39_minr645_maxr706_orgn0.pces Last file to copy: data/saved/preconsensus-events/0/2025/10/02/2025-10-02T10+26+02.898564122Z_seq40_minr679_maxr743_orgn0.pces
node0 8m 7.985s 2025-10-02 10:26:10.998 3217 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node0 8m 7.986s 2025-10-02 10:26:10.999 3218 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node0 8m 7.986s 2025-10-02 10:26:10.999 3219 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 715 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/715 {"round":715,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/715/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 8m 7.987s 2025-10-02 10:26:11.000 3220 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-02T10:26:07.467296Z ]
node0 8m 7.988s 2025-10-02 10:26:11.001 3221 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 2.3 s in FREEZING. Now in FREEZE_COMPLETE
node0 8m 7.988s 2025-10-02 10:26:11.001 3222 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 8m 7.988s 2025-10-02 10:26:11.001 3223 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-02T10:26:07.467296Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 8m 8.138s 2025-10-02 10:26:11.151 3211 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 715
node1 8m 8.140s 2025-10-02 10:26:11.153 3212 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 715 Timestamp: 2025-10-02T10:26:07.467296Z Next consensus number: 12095 Legacy running event hash: a57d81efb9e754c9df7cb9c6dd91ff1b8ed1a29a154f60b6e7417060f315a1cbf2f81c3a8d2294d21c3bbb7884fdf05f Legacy running event mnemonic: expire-season-segment-odor Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1245816835 Root hash: 8d8d2c9ee747bffaa45652cadfac09eec304dd1ee7f056925e7c5e7c84e4a23b902640a5e24c308df842ce388f615749 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / example-need-blame-absorb 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 prize-topic-monitor-shield 1 VirtualMap RosterService.ROSTERS /1 cement-leader-loyal-embody 2 SingletonNode RosterService.ROSTER_STATE /2 merge-paddle-flash-gesture 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 purpose-expand-tennis-flower 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 8m 8.151s 2025-10-02 10:26:11.164 3213 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+20+03.935120452Z_seq13_minr132_maxr178_orgn0.pces Last file: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+20+41.115726364Z_seq16_minr189_maxr236_orgn0.pces
node1 8m 8.151s 2025-10-02 10:26:11.164 3214 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 688 First file to copy: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+25+39.810323612Z_seq39_minr643_maxr704_orgn0.pces Last file to copy: data/saved/preconsensus-events/1/2025/10/02/2025-10-02T10+26+01.770354767Z_seq40_minr677_maxr741_orgn0.pces
node1 8m 8.151s 2025-10-02 10:26:11.164 3215 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node1 8m 8.152s 2025-10-02 10:26:11.165 3216 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node1 8m 8.153s 2025-10-02 10:26:11.166 3217 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 715 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/715 {"round":715,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/715/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node1 8m 8.154s 2025-10-02 10:26:11.167 3218 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-02T10:26:07.467296Z ]
node1 8m 8.154s 2025-10-02 10:26:11.167 3219 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 2.4 s in FREEZING. Now in FREEZE_COMPLETE
node1 8m 8.155s 2025-10-02 10:26:11.168 3220 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node1 8m 8.155s 2025-10-02 10:26:11.168 3221 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-02T10:26:07.467296Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]