Node ID






Columns











Log Level






Log Marker











Class















































node3 0.000ns 2025-10-27 10:20:27.210 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node3 89.000ms 2025-10-27 10:20:27.299 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 218.000ms 2025-10-27 10:20:27.428 3 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 225.000ms 2025-10-27 10:20:27.435 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 253.000ms 2025-10-27 10:20:27.463 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 255.000ms 2025-10-27 10:20:27.465 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 256.000ms 2025-10-27 10:20:27.466 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 256.000ms 2025-10-27 10:20:27.466 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 257.000ms 2025-10-27 10:20:27.467 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 257.000ms 2025-10-27 10:20:27.467 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 258.000ms 2025-10-27 10:20:27.468 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 258.000ms 2025-10-27 10:20:27.468 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 259.000ms 2025-10-27 10:20:27.469 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 259.000ms 2025-10-27 10:20:27.469 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 259.000ms 2025-10-27 10:20:27.469 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 260.000ms 2025-10-27 10:20:27.470 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 260.000ms 2025-10-27 10:20:27.470 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 261.000ms 2025-10-27 10:20:27.471 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 261.000ms 2025-10-27 10:20:27.471 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node3 692.000ms 2025-10-27 10:20:27.902 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 1.017s 2025-10-27 10:20:28.227 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 1.018s 2025-10-27 10:20:28.228 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 1.109s 2025-10-27 10:20:28.319 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 1.110s 2025-10-27 10:20:28.320 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 1.242s 2025-10-27 10:20:28.452 3 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node1 1.248s 2025-10-27 10:20:28.458 3 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node2 1.249s 2025-10-27 10:20:28.459 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node1 1.255s 2025-10-27 10:20:28.465 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 1.278s 2025-10-27 10:20:28.488 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 1.280s 2025-10-27 10:20:28.490 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 1.280s 2025-10-27 10:20:28.490 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 1.281s 2025-10-27 10:20:28.491 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 1.281s 2025-10-27 10:20:28.491 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 1.282s 2025-10-27 10:20:28.492 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 1.282s 2025-10-27 10:20:28.492 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 1.283s 2025-10-27 10:20:28.493 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 1.284s 2025-10-27 10:20:28.494 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 1.284s 2025-10-27 10:20:28.494 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 1.284s 2025-10-27 10:20:28.494 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.285s 2025-10-27 10:20:28.495 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 1.285s 2025-10-27 10:20:28.495 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 1.285s 2025-10-27 10:20:28.495 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 1.286s 2025-10-27 10:20:28.496 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 1.286s 2025-10-27 10:20:28.496 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 1.287s 2025-10-27 10:20:28.497 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.287s 2025-10-27 10:20:28.497 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.288s 2025-10-27 10:20:28.498 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.288s 2025-10-27 10:20:28.498 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.289s 2025-10-27 10:20:28.499 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.289s 2025-10-27 10:20:28.499 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.290s 2025-10-27 10:20:28.500 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 1.291s 2025-10-27 10:20:28.501 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.291s 2025-10-27 10:20:28.501 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.292s 2025-10-27 10:20:28.502 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.292s 2025-10-27 10:20:28.502 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.292s 2025-10-27 10:20:28.502 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.293s 2025-10-27 10:20:28.503 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.293s 2025-10-27 10:20:28.503 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node3 1.702s 2025-10-27 10:20:28.912 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1009ms
node2 1.704s 2025-10-27 10:20:28.914 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node1 1.724s 2025-10-27 10:20:28.934 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 1.747s 2025-10-27 10:20:28.957 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 1.811s 2025-10-27 10:20:29.021 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 1.812s 2025-10-27 10:20:29.022 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node2 2.607s 2025-10-27 10:20:29.817 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 902ms
node2 2.662s 2025-10-27 10:20:29.872 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node2 2.723s 2025-10-27 10:20:29.933 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 2.724s 2025-10-27 10:20:29.934 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 2.737s 2025-10-27 10:20:29.947 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1013ms
node1 2.785s 2025-10-27 10:20:29.995 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 2.850s 2025-10-27 10:20:30.060 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 2.851s 2025-10-27 10:20:30.061 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 2.906s 2025-10-27 10:20:30.116 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 3.008s 2025-10-27 10:20:30.218 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 3.141s 2025-10-27 10:20:30.351 3 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 3.148s 2025-10-27 10:20:30.358 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 3.179s 2025-10-27 10:20:30.389 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 3.180s 2025-10-27 10:20:30.390 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 3.180s 2025-10-27 10:20:30.390 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 3.181s 2025-10-27 10:20:30.391 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 3.181s 2025-10-27 10:20:30.391 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 3.182s 2025-10-27 10:20:30.392 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 3.182s 2025-10-27 10:20:30.392 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 3.183s 2025-10-27 10:20:30.393 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 3.184s 2025-10-27 10:20:30.394 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 3.184s 2025-10-27 10:20:30.394 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 3.185s 2025-10-27 10:20:30.395 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 3.185s 2025-10-27 10:20:30.395 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 3.185s 2025-10-27 10:20:30.395 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 3.186s 2025-10-27 10:20:30.396 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 3.186s 2025-10-27 10:20:30.396 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 3.623s 2025-10-27 10:20:30.833 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 3.887s 2025-10-27 10:20:31.097 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 3.974s 2025-10-27 10:20:31.184 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 3.975s 2025-10-27 10:20:31.185 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 3.975s 2025-10-27 10:20:31.185 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 3.975s 2025-10-27 10:20:31.185 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 3.976s 2025-10-27 10:20:31.186 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 3.976s 2025-10-27 10:20:31.186 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 3.976s 2025-10-27 10:20:31.186 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 3.977s 2025-10-27 10:20:31.187 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 3.980s 2025-10-27 10:20:31.190 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 3.984s 2025-10-27 10:20:31.194 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 3.984s 2025-10-27 10:20:31.194 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node0 4.613s 2025-10-27 10:20:31.823 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 989ms
node0 4.664s 2025-10-27 10:20:31.874 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 4.731s 2025-10-27 10:20:31.941 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 4.732s 2025-10-27 10:20:31.942 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 4.742s 2025-10-27 10:20:31.952 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 4.742s 2025-10-27 10:20:31.952 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 4.757s 2025-10-27 10:20:31.967 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 4.792s 2025-10-27 10:20:32.002 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node3 4.798s 2025-10-27 10:20:32.008 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 4.798s 2025-10-27 10:20:32.008 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 4.799s 2025-10-27 10:20:32.009 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node3 4.841s 2025-10-27 10:20:32.051 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 4.847s 2025-10-27 10:20:32.057 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 4.847s 2025-10-27 10:20:32.057 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 4.848s 2025-10-27 10:20:32.058 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 4.848s 2025-10-27 10:20:32.058 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 4.848s 2025-10-27 10:20:32.058 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 4.848s 2025-10-27 10:20:32.058 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 4.849s 2025-10-27 10:20:32.059 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 4.849s 2025-10-27 10:20:32.059 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 4.849s 2025-10-27 10:20:32.059 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 4.852s 2025-10-27 10:20:32.062 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.856s 2025-10-27 10:20:32.066 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 4.857s 2025-10-27 10:20:32.067 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node1 4.884s 2025-10-27 10:20:32.094 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node1 4.968s 2025-10-27 10:20:32.178 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 4.969s 2025-10-27 10:20:32.179 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 4.970s 2025-10-27 10:20:32.180 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 4.970s 2025-10-27 10:20:32.180 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 4.970s 2025-10-27 10:20:32.180 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 4.970s 2025-10-27 10:20:32.180 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 4.971s 2025-10-27 10:20:32.181 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 4.971s 2025-10-27 10:20:32.181 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 4.974s 2025-10-27 10:20:32.184 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 4.978s 2025-10-27 10:20:32.188 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 4.978s 2025-10-27 10:20:32.188 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node2 5.565s 2025-10-27 10:20:32.775 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.566s 2025-10-27 10:20:32.776 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.617s 2025-10-27 10:20:32.827 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node2 5.623s 2025-10-27 10:20:32.833 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.624s 2025-10-27 10:20:32.834 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.625s 2025-10-27 10:20:32.835 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node2 5.672s 2025-10-27 10:20:32.882 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 5.677s 2025-10-27 10:20:32.887 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 5.716s 2025-10-27 10:20:32.926 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.717s 2025-10-27 10:20:32.927 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 5.773s 2025-10-27 10:20:32.983 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node1 5.779s 2025-10-27 10:20:32.989 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.780s 2025-10-27 10:20:32.990 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 5.780s 2025-10-27 10:20:32.990 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node1 5.831s 2025-10-27 10:20:33.041 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 5.837s 2025-10-27 10:20:33.047 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 5.974s 2025-10-27 10:20:33.184 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26332109] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=305130, randomLong=2408447379997050385, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=10590, randomLong=6781509827164832725, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1303310, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms)
node3 6.002s 2025-10-27 10:20:33.212 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 6.009s 2025-10-27 10:20:33.219 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 6.014s 2025-10-27 10:20:33.224 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 6.093s 2025-10-27 10:20:33.303 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": "IimrkA==", "port": 30124 }, { "ipAddressV4": "CoAAfA==", "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": "Ij/fqw==", "port": 30125 }, { "ipAddressV4": "CoAAcg==", "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": "IjprCw==", "port": 30126 }, { "ipAddressV4": "CoAAcA==", "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": "IjfY+Q==", "port": 30127 }, { "ipAddressV4": "CoAAcQ==", "port": 30127 }] }] }
node3 6.192s 2025-10-27 10:20:33.402 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.192s 2025-10-27 10:20:33.402 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 6.195s 2025-10-27 10:20:33.405 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.195s 2025-10-27 10:20:33.405 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 6.195s 2025-10-27 10:20:33.405 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node3 6.198s 2025-10-27 10:20:33.408 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.199s 2025-10-27 10:20:33.409 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 6.199s 2025-10-27 10:20:33.409 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node3 6.201s 2025-10-27 10:20:33.411 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.202s 2025-10-27 10:20:33.412 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 6.202s 2025-10-27 10:20:33.412 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node3 6.216s 2025-10-27 10:20:33.426 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: 8b4608a45f9afdff18a65d401c3feaacd56c0b8b98a5c3283dd9cf3aa1a8eae28a25142f4e94a79e1cea2fc4a32e76e3 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 / nuclear-behind-viable-dizzy 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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
node3 6.411s 2025-10-27 10:20:33.621 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 6.416s 2025-10-27 10:20:33.626 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 6.427s 2025-10-27 10:20:33.637 138 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 6.427s 2025-10-27 10:20:33.637 139 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 6.430s 2025-10-27 10:20:33.640 140 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 6.431s 2025-10-27 10:20:33.641 141 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 6.431s 2025-10-27 10:20:33.641 142 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 6.431s 2025-10-27 10:20:33.641 143 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 6.432s 2025-10-27 10:20:33.642 144 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 6.432s 2025-10-27 10:20:33.642 145 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 6.432s 2025-10-27 10:20:33.642 146 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 6.432s 2025-10-27 10:20:33.642 147 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 6.432s 2025-10-27 10:20:33.642 148 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 6.432s 2025-10-27 10:20:33.642 149 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 6.433s 2025-10-27 10:20:33.643 150 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 6.433s 2025-10-27 10:20:33.643 151 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 6.433s 2025-10-27 10:20:33.643 152 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node3 6.449s 2025-10-27 10:20:33.659 153 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 6.450s 2025-10-27 10:20:33.660 154 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 6.450s 2025-10-27 10:20:33.660 155 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 6.450s 2025-10-27 10:20:33.660 156 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 6.451s 2025-10-27 10:20:33.661 157 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 6.451s 2025-10-27 10:20:33.661 158 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node3 6.452s 2025-10-27 10:20:33.662 159 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 6.453s 2025-10-27 10:20:33.663 160 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node3 6.458s 2025-10-27 10:20:33.668 161 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@67bb24ad
node3 6.460s 2025-10-27 10:20:33.670 162 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 80000
node3 6.460s 2025-10-27 10:20:33.670 163 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node3 6.467s 2025-10-27 10:20:33.677 168 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@482f7948, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@50c18d73,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@27a3ebf6,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6cb1063a,snapshotInProgress=false]
node3 6.475s 2025-10-27 10:20:33.685 169 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 6.475s 2025-10-27 10:20:33.685 170 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 6.479s 2025-10-27 10:20:33.689 171 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is -7432025218373113270
node3 6.480s 2025-10-27 10:20:33.690 172 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 6.561s 2025-10-27 10:20:33.771 173 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 6.562s 2025-10-27 10:20:33.772 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 6.567s 2025-10-27 10:20:33.777 175 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 6.569s 2025-10-27 10:20:33.779 176 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 6.569s 2025-10-27 10:20:33.779 177 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 6.571s 2025-10-27 10:20:33.781 178 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 6.571s 2025-10-27 10:20:33.781 179 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 6.573s 2025-10-27 10:20:33.783 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 6.575s 2025-10-27 10:20:33.785 181 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 6.575s 2025-10-27 10:20:33.785 182 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 305.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 6.578s 2025-10-27 10:20:33.788 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 6.579s 2025-10-27 10:20:33.789 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 6.579s 2025-10-27 10:20:33.789 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 6.797s 2025-10-27 10:20:34.007 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26156552] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=233700, randomLong=8870445373980579900, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=16170, randomLong=-5574097622281488304, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1441921, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms)
node0 6.827s 2025-10-27 10:20:34.037 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 6.829s 2025-10-27 10:20:34.039 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node2 6.836s 2025-10-27 10:20:34.046 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 6.841s 2025-10-27 10:20:34.051 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 6.926s 2025-10-27 10:20:34.136 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 6.927s 2025-10-27 10:20:34.137 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 6.927s 2025-10-27 10:20:34.137 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 6.928s 2025-10-27 10:20:34.138 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 6.928s 2025-10-27 10:20:34.138 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 6.928s 2025-10-27 10:20:34.138 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 6.928s 2025-10-27 10:20:34.138 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 6.929s 2025-10-27 10:20:34.139 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 6.931s 2025-10-27 10:20:34.141 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": "IimrkA==", "port": 30124 }, { "ipAddressV4": "CoAAfA==", "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": "Ij/fqw==", "port": 30125 }, { "ipAddressV4": "CoAAcg==", "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": "IjprCw==", "port": 30126 }, { "ipAddressV4": "CoAAcA==", "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": "IjfY+Q==", "port": 30127 }, { "ipAddressV4": "CoAAcQ==", "port": 30127 }] }] }
node0 6.932s 2025-10-27 10:20:34.142 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 6.936s 2025-10-27 10:20:34.146 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 6.936s 2025-10-27 10:20:34.146 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node1 6.981s 2025-10-27 10:20:34.191 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26241006] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=167270, randomLong=-1323388035020361330, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=15800, randomLong=191768967991650968, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1013950, data=35, exception=null] OS Health Check Report - Complete (took 1025 ms)
node1 7.013s 2025-10-27 10:20:34.223 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 7.021s 2025-10-27 10:20:34.231 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 7.027s 2025-10-27 10:20:34.237 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 7.035s 2025-10-27 10:20:34.245 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 7.036s 2025-10-27 10:20:34.246 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 7.038s 2025-10-27 10:20:34.248 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 7.038s 2025-10-27 10:20:34.248 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 7.039s 2025-10-27 10:20:34.249 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node2 7.042s 2025-10-27 10:20:34.252 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 7.042s 2025-10-27 10:20:34.252 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 7.042s 2025-10-27 10:20:34.252 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node2 7.044s 2025-10-27 10:20:34.254 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 7.044s 2025-10-27 10:20:34.254 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 7.045s 2025-10-27 10:20:34.255 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node2 7.060s 2025-10-27 10:20:34.270 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: 8b4608a45f9afdff18a65d401c3feaacd56c0b8b98a5c3283dd9cf3aa1a8eae28a25142f4e94a79e1cea2fc4a32e76e3 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 / nuclear-behind-viable-dizzy 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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.111s 2025-10-27 10:20:34.321 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": "IimrkA==", "port": 30124 }, { "ipAddressV4": "CoAAfA==", "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": "Ij/fqw==", "port": 30125 }, { "ipAddressV4": "CoAAcg==", "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": "IjprCw==", "port": 30126 }, { "ipAddressV4": "CoAAcA==", "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": "IjfY+Q==", "port": 30127 }, { "ipAddressV4": "CoAAcQ==", "port": 30127 }] }] }
node1 7.211s 2025-10-27 10:20:34.421 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.211s 2025-10-27 10:20:34.421 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 7.214s 2025-10-27 10:20:34.424 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.214s 2025-10-27 10:20:34.424 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 7.214s 2025-10-27 10:20:34.424 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node1 7.218s 2025-10-27 10:20:34.428 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.218s 2025-10-27 10:20:34.428 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 7.219s 2025-10-27 10:20:34.429 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node1 7.221s 2025-10-27 10:20:34.431 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.221s 2025-10-27 10:20:34.431 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 7.221s 2025-10-27 10:20:34.431 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node1 7.236s 2025-10-27 10:20:34.446 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: 8b4608a45f9afdff18a65d401c3feaacd56c0b8b98a5c3283dd9cf3aa1a8eae28a25142f4e94a79e1cea2fc4a32e76e3 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 / nuclear-behind-viable-dizzy 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 7.266s 2025-10-27 10:20:34.476 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 7.271s 2025-10-27 10:20:34.481 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 7.281s 2025-10-27 10:20:34.491 138 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 7.282s 2025-10-27 10:20:34.492 139 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 7.284s 2025-10-27 10:20:34.494 140 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 7.284s 2025-10-27 10:20:34.494 141 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 7.285s 2025-10-27 10:20:34.495 142 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 7.285s 2025-10-27 10:20:34.495 143 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 7.285s 2025-10-27 10:20:34.495 144 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 7.285s 2025-10-27 10:20:34.495 145 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 7.285s 2025-10-27 10:20:34.495 146 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 7.286s 2025-10-27 10:20:34.496 147 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 7.286s 2025-10-27 10:20:34.496 148 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 7.286s 2025-10-27 10:20:34.496 149 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 7.286s 2025-10-27 10:20:34.496 150 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 7.286s 2025-10-27 10:20:34.496 151 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 7.286s 2025-10-27 10:20:34.496 152 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node2 7.302s 2025-10-27 10:20:34.512 153 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 7.302s 2025-10-27 10:20:34.512 154 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 7.302s 2025-10-27 10:20:34.512 155 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 7.303s 2025-10-27 10:20:34.513 156 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 7.303s 2025-10-27 10:20:34.513 157 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 7.303s 2025-10-27 10:20:34.513 158 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node2 7.304s 2025-10-27 10:20:34.514 159 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 7.305s 2025-10-27 10:20:34.515 160 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node2 7.310s 2025-10-27 10:20:34.520 161 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@5fed2b65
node2 7.311s 2025-10-27 10:20:34.521 162 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 80000
node2 7.311s 2025-10-27 10:20:34.521 163 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node2 7.319s 2025-10-27 10:20:34.529 168 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@2158cfc6, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@7f26e7ec,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@1dada210,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@d79e326,snapshotInProgress=false]
node2 7.327s 2025-10-27 10:20:34.537 169 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 7.328s 2025-10-27 10:20:34.538 170 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 7.332s 2025-10-27 10:20:34.542 171 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is -7879973512588214340
node2 7.332s 2025-10-27 10:20:34.542 172 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node2 7.410s 2025-10-27 10:20:34.620 173 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node2 7.411s 2025-10-27 10:20:34.621 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 7.415s 2025-10-27 10:20:34.625 175 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 7.416s 2025-10-27 10:20:34.626 176 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 7.417s 2025-10-27 10:20:34.627 177 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 7.418s 2025-10-27 10:20:34.628 178 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node2 7.419s 2025-10-27 10:20:34.629 179 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 7.420s 2025-10-27 10:20:34.630 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 7.421s 2025-10-27 10:20:34.631 182 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 7.421s 2025-10-27 10:20:34.631 181 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 306.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 7.426s 2025-10-27 10:20:34.636 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 7.427s 2025-10-27 10:20:34.637 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 7.427s 2025-10-27 10:20:34.637 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 7.463s 2025-10-27 10:20:34.673 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 7.468s 2025-10-27 10:20:34.678 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 7.479s 2025-10-27 10:20:34.689 138 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 7.480s 2025-10-27 10:20:34.690 139 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 7.482s 2025-10-27 10:20:34.692 140 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 7.483s 2025-10-27 10:20:34.693 141 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 7.483s 2025-10-27 10:20:34.693 142 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 7.483s 2025-10-27 10:20:34.693 143 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 7.483s 2025-10-27 10:20:34.693 144 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 7.483s 2025-10-27 10:20:34.693 145 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 7.484s 2025-10-27 10:20:34.694 146 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 7.484s 2025-10-27 10:20:34.694 147 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 7.484s 2025-10-27 10:20:34.694 148 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 7.484s 2025-10-27 10:20:34.694 149 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 7.484s 2025-10-27 10:20:34.694 150 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 7.484s 2025-10-27 10:20:34.694 151 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 7.485s 2025-10-27 10:20:34.695 152 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node1 7.500s 2025-10-27 10:20:34.710 153 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 7.501s 2025-10-27 10:20:34.711 154 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 7.501s 2025-10-27 10:20:34.711 155 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 7.501s 2025-10-27 10:20:34.711 156 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 7.502s 2025-10-27 10:20:34.712 157 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 7.502s 2025-10-27 10:20:34.712 158 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node1 7.503s 2025-10-27 10:20:34.713 159 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 7.504s 2025-10-27 10:20:34.714 160 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node1 7.512s 2025-10-27 10:20:34.722 161 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@741b5e5f
node1 7.513s 2025-10-27 10:20:34.723 162 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 80000
node1 7.514s 2025-10-27 10:20:34.724 163 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node1 7.522s 2025-10-27 10:20:34.732 168 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@36a7d4c0, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@47a3fe6d,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@199c2335,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@697dbfbd,snapshotInProgress=false]
node1 7.531s 2025-10-27 10:20:34.741 169 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 7.532s 2025-10-27 10:20:34.742 170 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 7.536s 2025-10-27 10:20:34.746 171 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is -5168242932587596066
node1 7.537s 2025-10-27 10:20:34.747 172 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 7.623s 2025-10-27 10:20:34.833 173 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 7.625s 2025-10-27 10:20:34.835 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 7.629s 2025-10-27 10:20:34.839 175 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 7.629s 2025-10-27 10:20:34.839 176 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 7.630s 2025-10-27 10:20:34.840 177 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 7.631s 2025-10-27 10:20:34.841 178 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 7.632s 2025-10-27 10:20:34.842 179 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 7.633s 2025-10-27 10:20:34.843 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 7.634s 2025-10-27 10:20:34.844 181 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 7.635s 2025-10-27 10:20:34.845 182 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 342.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 7.640s 2025-10-27 10:20:34.850 183 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 7.641s 2025-10-27 10:20:34.851 184 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 7.642s 2025-10-27 10:20:34.852 185 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 7.822s 2025-10-27 10:20:35.032 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 7.823s 2025-10-27 10:20:35.033 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 7.891s 2025-10-27 10:20:35.101 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node0 7.897s 2025-10-27 10:20:35.107 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 7.897s 2025-10-27 10:20:35.107 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 7.898s 2025-10-27 10:20:35.108 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node0 7.950s 2025-10-27 10:20:35.160 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 7.957s 2025-10-27 10:20:35.167 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node0 9.079s 2025-10-27 10:20:36.289 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26203452] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=245251, randomLong=1655969876878544354, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=16080, randomLong=2759953418139825602, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1413709, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms)
node0 9.112s 2025-10-27 10:20:36.322 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 9.122s 2025-10-27 10:20:36.332 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 9.127s 2025-10-27 10:20:36.337 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 9.216s 2025-10-27 10:20:36.426 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": "IimrkA==", "port": 30124 }, { "ipAddressV4": "CoAAfA==", "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": "Ij/fqw==", "port": 30125 }, { "ipAddressV4": "CoAAcg==", "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": "IjprCw==", "port": 30126 }, { "ipAddressV4": "CoAAcA==", "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": "IjfY+Q==", "port": 30127 }, { "ipAddressV4": "CoAAcQ==", "port": 30127 }] }] }
node0 9.318s 2025-10-27 10:20:36.528 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 9.319s 2025-10-27 10:20:36.529 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 9.321s 2025-10-27 10:20:36.531 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 9.321s 2025-10-27 10:20:36.531 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 9.322s 2025-10-27 10:20:36.532 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node0 9.325s 2025-10-27 10:20:36.535 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 9.326s 2025-10-27 10:20:36.536 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 9.326s 2025-10-27 10:20:36.536 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node0 9.330s 2025-10-27 10:20:36.540 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 9.330s 2025-10-27 10:20:36.540 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 9.330s 2025-10-27 10:20:36.540 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node0 9.350s 2025-10-27 10:20:36.560 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: 8b4608a45f9afdff18a65d401c3feaacd56c0b8b98a5c3283dd9cf3aa1a8eae28a25142f4e94a79e1cea2fc4a32e76e3 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 / nuclear-behind-viable-dizzy 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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
node3 9.434s 2025-10-27 10:20:36.644 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 9.436s 2025-10-27 10:20:36.646 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 9.609s 2025-10-27 10:20:36.819 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 9.615s 2025-10-27 10:20:36.825 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 9.627s 2025-10-27 10:20:36.837 138 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 9.627s 2025-10-27 10:20:36.837 139 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 9.631s 2025-10-27 10:20:36.841 140 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 9.632s 2025-10-27 10:20:36.842 141 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 9.632s 2025-10-27 10:20:36.842 142 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 9.632s 2025-10-27 10:20:36.842 143 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 9.632s 2025-10-27 10:20:36.842 144 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 9.633s 2025-10-27 10:20:36.843 145 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 9.633s 2025-10-27 10:20:36.843 146 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 9.633s 2025-10-27 10:20:36.843 147 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 9.633s 2025-10-27 10:20:36.843 148 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 9.633s 2025-10-27 10:20:36.843 149 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 9.634s 2025-10-27 10:20:36.844 150 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 9.634s 2025-10-27 10:20:36.844 151 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 9.634s 2025-10-27 10:20:36.844 152 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 9.652s 2025-10-27 10:20:36.862 153 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 9.653s 2025-10-27 10:20:36.863 154 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 9.653s 2025-10-27 10:20:36.863 155 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 9.654s 2025-10-27 10:20:36.864 156 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 9.654s 2025-10-27 10:20:36.864 157 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 9.654s 2025-10-27 10:20:36.864 158 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node0 9.655s 2025-10-27 10:20:36.865 159 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 9.656s 2025-10-27 10:20:36.866 160 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node0 9.662s 2025-10-27 10:20:36.872 161 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@67bb24ad
node0 9.662s 2025-10-27 10:20:36.872 162 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 80000
node0 9.663s 2025-10-27 10:20:36.873 163 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node0 9.671s 2025-10-27 10:20:36.881 168 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@482f7948, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@50c18d73,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@27a3ebf6,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6cb1063a,snapshotInProgress=false]
node0 9.681s 2025-10-27 10:20:36.891 169 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 9.682s 2025-10-27 10:20:36.892 170 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 9.689s 2025-10-27 10:20:36.899 171 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is 1709725615782182353
node0 9.690s 2025-10-27 10:20:36.900 172 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 9.779s 2025-10-27 10:20:36.989 173 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 9.781s 2025-10-27 10:20:36.991 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 9.786s 2025-10-27 10:20:36.996 175 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 9.787s 2025-10-27 10:20:36.997 176 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 9.788s 2025-10-27 10:20:36.998 177 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 9.790s 2025-10-27 10:20:37.000 178 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 9.790s 2025-10-27 10:20:37.000 179 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 9.792s 2025-10-27 10:20:37.002 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 9.793s 2025-10-27 10:20:37.003 181 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 373.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 9.793s 2025-10-27 10:20:37.003 182 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 9.798s 2025-10-27 10:20:37.008 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 9.799s 2025-10-27 10:20:37.009 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 9.800s 2025-10-27 10:20:37.010 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 10.288s 2025-10-27 10:20:37.498 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 10.290s 2025-10-27 10:20:37.500 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.487s 2025-10-27 10:20:37.697 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.489s 2025-10-27 10:20:37.699 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 12.635s 2025-10-27 10:20:39.845 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 12.637s 2025-10-27 10:20:39.847 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 16.671s 2025-10-27 10:20:43.881 188 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 16.673s 2025-10-27 10:20:43.883 189 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node2 17.518s 2025-10-27 10:20:44.728 188 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 17.519s 2025-10-27 10:20:44.729 189 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node1 17.730s 2025-10-27 10:20:44.940 188 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 17.731s 2025-10-27 10:20:44.941 189 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node2 19.243s 2025-10-27 10:20:46.453 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 19.316s 2025-10-27 10:20:46.526 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 19.316s 2025-10-27 10:20:46.526 191 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.6 s in CHECKING. Now in ACTIVE
node3 19.317s 2025-10-27 10:20:46.527 192 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 19.385s 2025-10-27 10:20:46.595 193 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x8FCEF68E017DA39F12701931F95FC10D638706B8B41A4F111D83E6AB140B7ECE', privateKey ='0x8FCEF68E017DA39F12701931F95FC10D638706B8B41A4F111D83E6AB140B7ECE', signature = '0xBDC3EDB8452BD3EE427217BCD4616408FCC78A1EB6E7E1B9154B7B218DA5D66ABDE5B672E17A6988BD38C274A51E29CB95FEB578D92723D42254CC2352C1A908',message = '0x12660A1E080310031880D30E2080D30E2880D30E3080D30E40C2D6B49D879FC1AC1C32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003803' }
node1 19.418s 2025-10-27 10:20:46.628 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 19.446s 2025-10-27 10:20:46.656 188 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 19.889s 2025-10-27 10:20:47.099 189 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 19.890s 2025-10-27 10:20:47.100 190 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node1 20.216s 2025-10-27 10:20:47.426 191 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.5 s in CHECKING. Now in ACTIVE
node1 20.216s 2025-10-27 10:20:47.426 192 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 20.268s 2025-10-27 10:20:47.478 193 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x971E21793FDF7E437B906BF582F1034592CF484DE560592C760A67216B7D3D0B', privateKey ='0x971E21793FDF7E437B906BF582F1034592CF484DE560592C760A67216B7D3D0B', signature = '0x37C136621BA75ED725BD5E09AA2B2C4F93135AF6E3775D05FA0676230672D2CE465659DBB32FACE5D20D9AEC5CB5E57270FEBEF297206596327CB66395FC6907',message = '0x12660A1E080110011880F1042080F1042880F1043080F10440A8C88AC1DAE1CAC41B32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003801' }
node2 20.357s 2025-10-27 10:20:47.567 191 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 2.8 s in CHECKING. Now in ACTIVE
node2 20.358s 2025-10-27 10:20:47.568 192 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 20.406s 2025-10-27 10:20:47.616 193 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xDE0921D38EFDCDC073C6B5B6ADFFAC225AC58128359BDFE81F11E8038C8AA87E', privateKey ='0xDE0921D38EFDCDC073C6B5B6ADFFAC225AC58128359BDFE81F11E8038C8AA87E', signature = '0xA4A1194FAC06BF308E81424657923E46E13C1B19A93E544ECAF9D2B8A92B8E76A8669052EFFE4EC8F97088746977F299AEC3662EC791D6AD231F12E0F21DBE0B',message = '0x12660A1E080210021880E2092080E2092880E2093080E2094092E5E0FAE4EAA3C17632420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003802' }
node3 21.213s 2025-10-27 10:20:48.423 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.331s 2025-10-27 10:20:48.541 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.354s 2025-10-27 10:20:48.564 193 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.403s 2025-10-27 10:20:48.613 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 22.114s 2025-10-27 10:20:49.324 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 22.116s 2025-10-27 10:20:49.326 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 22.139s 2025-10-27 10:20:49.349 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 22.141s 2025-10-27 10:20:49.351 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
node2 22.183s 2025-10-27 10:20:49.393 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 22.185s 2025-10-27 10:20:49.395 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 22.291s 2025-10-27 10:20:49.501 202 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 22.294s 2025-10-27 10:20:49.504 203 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 22.394s 2025-10-27 10:20:49.604 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.397s 2025-10-27 10:20:49.607 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-27T10:20:46.620468Z Next consensus number: 17 Legacy running event hash: ee65fcff745ba4adcf0ec725fe543d1f3669680c5a527b8bc76b6d0448606950c4d3988966568788c7e7f5574c314d79 Legacy running event mnemonic: cricket-gasp-merge-heavy Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: caf2f5a8935f165ed48c06ed0e76375ae6ad7a43e6560eab0f74917706a8fee3ab194365ae4f4d253ee0ac7382e68629 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 / peace-enrich-neither-slim 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 pride-genre-hip-solid 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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
node1 22.406s 2025-10-27 10:20:49.616 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 22.410s 2025-10-27 10:20:49.620 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-27T10:20:46.620468Z Next consensus number: 17 Legacy running event hash: ee65fcff745ba4adcf0ec725fe543d1f3669680c5a527b8bc76b6d0448606950c4d3988966568788c7e7f5574c314d79 Legacy running event mnemonic: cricket-gasp-merge-heavy Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: caf2f5a8935f165ed48c06ed0e76375ae6ad7a43e6560eab0f74917706a8fee3ab194365ae4f4d253ee0ac7382e68629 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 / peace-enrich-neither-slim 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 pride-genre-hip-solid 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 22.420s 2025-10-27 10:20:49.630 215 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 2.5 s in CHECKING. Now in ACTIVE
node0 22.421s 2025-10-27 10:20:49.631 216 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 22.425s 2025-10-27 10:20:49.635 217 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xF265F7757EF0A74BD5B0CDABF96ABF761F903614FFB3993BCB83D3AB4920336F', privateKey ='0xF265F7757EF0A74BD5B0CDABF96ABF761F903614FFB3993BCB83D3AB4920336F', signature = '0xE0D91BCC4666BA12A30B0FA20454554D869B57ABFA18A6A78FD79B81A646DE3B8CB22BFCA7C92C0944B8C333667FE2C634878452C940E9A88EDB670E24C3B50C',message = '0x12660A0A4084E683FCAEF590B340325800000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' }
node3 22.429s 2025-10-27 10:20:49.639 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/10/27/2025-10-27T10+20+43.923657755Z_seq0_minr1_maxr501_orgn0.pces
node3 22.430s 2025-10-27 10:20:49.640 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/27/2025-10-27T10+20+43.923657755Z_seq0_minr1_maxr501_orgn0.pces
node3 22.430s 2025-10-27 10:20:49.640 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 22.433s 2025-10-27 10:20:49.643 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 22.437s 2025-10-27 10:20:49.647 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]
node1 22.453s 2025-10-27 10:20:49.663 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/10/27/2025-10-27T10+20+44.368959468Z_seq0_minr1_maxr501_orgn0.pces
node1 22.454s 2025-10-27 10:20:49.664 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/27/2025-10-27T10+20+44.368959468Z_seq0_minr1_maxr501_orgn0.pces
node1 22.455s 2025-10-27 10:20:49.665 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 22.458s 2025-10-27 10:20:49.668 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 22.463s 2025-10-27 10:20:49.673 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]
node2 22.470s 2025-10-27 10:20:49.680 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.474s 2025-10-27 10:20:49.684 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-27T10:20:46.620468Z Next consensus number: 17 Legacy running event hash: ee65fcff745ba4adcf0ec725fe543d1f3669680c5a527b8bc76b6d0448606950c4d3988966568788c7e7f5574c314d79 Legacy running event mnemonic: cricket-gasp-merge-heavy Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: caf2f5a8935f165ed48c06ed0e76375ae6ad7a43e6560eab0f74917706a8fee3ab194365ae4f4d253ee0ac7382e68629 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 / peace-enrich-neither-slim 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 pride-genre-hip-solid 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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.508s 2025-10-27 10:20:49.718 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/10/27/2025-10-27T10+20+44.181036313Z_seq0_minr1_maxr501_orgn0.pces
node2 22.509s 2025-10-27 10:20:49.719 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/27/2025-10-27T10+20+44.181036313Z_seq0_minr1_maxr501_orgn0.pces
node2 22.509s 2025-10-27 10:20:49.719 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 22.512s 2025-10-27 10:20:49.722 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 22.517s 2025-10-27 10:20:49.727 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]
node0 22.609s 2025-10-27 10:20:49.819 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 22.614s 2025-10-27 10:20:49.824 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-27T10:20:46.620468Z Next consensus number: 17 Legacy running event hash: ee65fcff745ba4adcf0ec725fe543d1f3669680c5a527b8bc76b6d0448606950c4d3988966568788c7e7f5574c314d79 Legacy running event mnemonic: cricket-gasp-merge-heavy Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: caf2f5a8935f165ed48c06ed0e76375ae6ad7a43e6560eab0f74917706a8fee3ab194365ae4f4d253ee0ac7382e68629 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 / peace-enrich-neither-slim 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 pride-genre-hip-solid 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 22.661s 2025-10-27 10:20:49.871 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/10/27/2025-10-27T10+20+44.536191354Z_seq0_minr1_maxr501_orgn0.pces
node0 22.663s 2025-10-27 10:20:49.873 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/27/2025-10-27T10+20+44.536191354Z_seq0_minr1_maxr501_orgn0.pces
node0 22.664s 2025-10-27 10:20:49.874 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 22.667s 2025-10-27 10:20:49.877 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 22.674s 2025-10-27 10:20:49.884 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 1m 39.392s 2025-10-27 10:22:06.602 734 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 40.288s 2025-10-27 10:22:07.498 742 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 40.448s 2025-10-27 10:22:07.658 742 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 42.448s 2025-10-27 10:22:09.658 754 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 6m 59.387s 2025-10-27 10:27:26.597 2655 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 6m 59.389s 2025-10-27 10:27:26.599 2656 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 6m 59.392s 2025-10-27 10:27:26.602 2657 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 6m 59.392s 2025-10-27 10:27:26.602 2658 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node1 7.004m 2025-10-27 10:27:27.479 2663 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 7.005m 2025-10-27 10:27:27.481 2664 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 7.005m 2025-10-27 10:27:27.481 2665 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 7.005m 2025-10-27 10:27:27.481 2666 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node2 7.007m 2025-10-27 10:27:27.644 2663 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 7.007m 2025-10-27 10:27:27.646 2664 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 7.007m 2025-10-27 10:27:27.646 2665 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 7.007m 2025-10-27 10:27:27.647 2666 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node3 7m 1.447s 2025-10-27 10:27:28.657 2679 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:26.928236405Z ]
node3 7m 1.448s 2025-10-27 10:27:28.658 2680 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:26.928236405Z,type=ENTER_VALIDATION]
node2 7m 1.452s 2025-10-27 10:27:28.662 2671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:26.928236405Z ]
node2 7m 1.453s 2025-10-27 10:27:28.663 2672 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:26.928236405Z,type=ENTER_VALIDATION]
node0 7m 1.464s 2025-10-27 10:27:28.674 2675 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:26.928236405Z ]
node0 7m 1.466s 2025-10-27 10:27:28.676 2676 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:26.928236405Z,type=ENTER_VALIDATION]
node1 7m 1.476s 2025-10-27 10:27:28.686 2671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:26.928236405Z ]
node1 7m 1.477s 2025-10-27 10:27:28.687 2672 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:26.928236405Z,type=ENTER_VALIDATION]
node1 7m 2.035s 2025-10-27 10:27:29.245 2681 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051107392Z ]
node1 7m 2.036s 2025-10-27 10:27:29.246 2682 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:28.051107392Z,type=ENTER_VALIDATION]
node1 7m 2.037s 2025-10-27 10:27:29.247 2683 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051264Z ]
node1 7m 2.037s 2025-10-27 10:27:29.247 2684 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:28.051264Z,type=ENTER_VALIDATION]
node2 7m 2.113s 2025-10-27 10:27:29.323 2681 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051107392Z ]
node2 7m 2.113s 2025-10-27 10:27:29.323 2682 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:28.051107392Z,type=ENTER_VALIDATION]
node2 7m 2.114s 2025-10-27 10:27:29.324 2683 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051264Z ]
node2 7m 2.115s 2025-10-27 10:27:29.325 2684 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:28.051264Z,type=ENTER_VALIDATION]
node3 7m 2.248s 2025-10-27 10:27:29.458 2681 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051107392Z ]
node3 7m 2.248s 2025-10-27 10:27:29.458 2682 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:28.051107392Z,type=ENTER_VALIDATION]
node3 7m 2.249s 2025-10-27 10:27:29.459 2683 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051264Z ]
node3 7m 2.249s 2025-10-27 10:27:29.459 2684 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:28.051264Z,type=ENTER_VALIDATION]
node0 7m 2.308s 2025-10-27 10:27:29.518 2677 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051107392Z ]
node0 7m 2.308s 2025-10-27 10:27:29.518 2678 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:28.051107392Z,type=ENTER_VALIDATION]
node0 7m 2.309s 2025-10-27 10:27:29.519 2679 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:28.051264Z ]
node0 7m 2.309s 2025-10-27 10:27:29.519 2680 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:28.051264Z,type=ENTER_VALIDATION]
node0 7m 2.433s 2025-10-27 10:27:29.643 2681 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 7m 2.434s 2025-10-27 10:27:29.644 2682 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 7m 2.435s 2025-10-27 10:27:29.645 2683 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 7m 2.435s 2025-10-27 10:27:29.645 2684 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node1 7m 4.848s 2025-10-27 10:27:32.058 2697 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:30.147711731Z ]
node1 7m 4.848s 2025-10-27 10:27:32.058 2698 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:30.147711731Z,type=ENTER_VALIDATION]
node1 7m 4.849s 2025-10-27 10:27:32.059 2699 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node1 7m 4.854s 2025-10-27 10:27:32.064 2704 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node1 7m 4.855s 2025-10-27 10:27:32.065 2705 INFO DEMO_INFO <<PTT: enter-validator 1>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node1 7m 4.855s 2025-10-27 10:27:32.065 2706 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1761560850147_147711731.json.gz
node1 7m 4.860s 2025-10-27 10:27:32.070 2707 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node1 7m 4.861s 2025-10-27 10:27:32.071 2708 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:30.147711731Z ]
node2 7m 4.925s 2025-10-27 10:27:32.135 2697 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:30.147711731Z ]
node2 7m 4.925s 2025-10-27 10:27:32.135 2698 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:30.147711731Z,type=ENTER_VALIDATION]
node2 7m 4.926s 2025-10-27 10:27:32.136 2699 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node2 7m 4.931s 2025-10-27 10:27:32.141 2704 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node2 7m 4.932s 2025-10-27 10:27:32.142 2705 INFO DEMO_INFO <<PTT: enter-validator 2>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node2 7m 4.933s 2025-10-27 10:27:32.143 2706 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1761560850147_147711731.json.gz
node2 7m 4.938s 2025-10-27 10:27:32.148 2707 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node2 7m 4.938s 2025-10-27 10:27:32.148 2708 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:30.147711731Z ]
node3 7m 5.059s 2025-10-27 10:27:32.269 2697 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:30.147711731Z ]
node3 7m 5.059s 2025-10-27 10:27:32.269 2698 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:30.147711731Z,type=ENTER_VALIDATION]
node3 7m 5.060s 2025-10-27 10:27:32.270 2699 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node3 7m 5.066s 2025-10-27 10:27:32.276 2704 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node3 7m 5.067s 2025-10-27 10:27:32.277 2705 INFO DEMO_INFO <<PTT: enter-validator 3>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node3 7m 5.068s 2025-10-27 10:27:32.278 2706 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1761560850147_147711731.json.gz
node3 7m 5.073s 2025-10-27 10:27:32.283 2707 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node3 7m 5.073s 2025-10-27 10:27:32.283 2708 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:30.147711731Z ]
node0 7m 5.131s 2025-10-27 10:27:32.341 2697 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-27T10:27:30.147711731Z ]
node0 7m 5.131s 2025-10-27 10:27:32.341 2698 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:30.147711731Z,type=ENTER_VALIDATION]
node0 7m 5.133s 2025-10-27 10:27:32.343 2699 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node0 7m 5.142s 2025-10-27 10:27:32.352 2704 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node0 7m 5.145s 2025-10-27 10:27:32.355 2705 INFO DEMO_INFO <<PTT: enter-validator 0>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node0 7m 5.146s 2025-10-27 10:27:32.356 2706 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1761560850147_147711731.json.gz
node0 7m 5.158s 2025-10-27 10:27:32.368 2707 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1761560850147_147711731.json, consensusTime = 2025-10-27T10:27:30.147711731Z ]
node0 7m 5.160s 2025-10-27 10:27:32.370 2708 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:30.147711731Z ]
node2 7m 7.063s 2025-10-27 10:27:34.273 2717 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.418216Z ]
node2 7m 7.064s 2025-10-27 10:27:34.274 2718 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:32.418216Z,type=EXIT_VALIDATION]
node2 7m 7.065s 2025-10-27 10:27:34.275 2719 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.588863723Z ]
node2 7m 7.065s 2025-10-27 10:27:34.275 2720 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:32.588863723Z,type=EXIT_VALIDATION]
node2 7m 7.065s 2025-10-27 10:27:34.275 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900558421Z ]
node2 7m 7.065s 2025-10-27 10:27:34.275 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:32.900558421Z,type=EXIT_VALIDATION]
node3 7m 7.077s 2025-10-27 10:27:34.287 2717 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.418216Z ]
node3 7m 7.078s 2025-10-27 10:27:34.288 2718 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:32.418216Z,type=EXIT_VALIDATION]
node3 7m 7.078s 2025-10-27 10:27:34.288 2719 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.588863723Z ]
node3 7m 7.078s 2025-10-27 10:27:34.288 2720 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:32.588863723Z,type=EXIT_VALIDATION]
node3 7m 7.078s 2025-10-27 10:27:34.288 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900558421Z ]
node3 7m 7.078s 2025-10-27 10:27:34.288 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:32.900558421Z,type=EXIT_VALIDATION]
node1 7m 7.107s 2025-10-27 10:27:34.317 2717 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.418216Z ]
node1 7m 7.108s 2025-10-27 10:27:34.318 2718 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:32.418216Z,type=EXIT_VALIDATION]
node1 7m 7.108s 2025-10-27 10:27:34.318 2719 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.588863723Z ]
node1 7m 7.108s 2025-10-27 10:27:34.318 2720 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:32.588863723Z,type=EXIT_VALIDATION]
node1 7m 7.108s 2025-10-27 10:27:34.318 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900558421Z ]
node1 7m 7.108s 2025-10-27 10:27:34.318 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:32.900558421Z,type=EXIT_VALIDATION]
node0 7m 7.127s 2025-10-27 10:27:34.337 2717 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.418216Z ]
node0 7m 7.127s 2025-10-27 10:27:34.337 2718 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-27T10:27:32.418216Z,type=EXIT_VALIDATION]
node0 7m 7.127s 2025-10-27 10:27:34.337 2719 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.588863723Z ]
node0 7m 7.128s 2025-10-27 10:27:34.338 2720 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-27T10:27:32.588863723Z,type=EXIT_VALIDATION]
node0 7m 7.128s 2025-10-27 10:27:34.338 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900558421Z ]
node0 7m 7.128s 2025-10-27 10:27:34.338 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-27T10:27:32.900558421Z,type=EXIT_VALIDATION]
node0 7m 7.626s 2025-10-27 10:27:34.836 2727 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900565Z ]
node0 7m 7.627s 2025-10-27 10:27:34.837 2728 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:32.900565Z,type=EXIT_VALIDATION]
node0 7m 7.627s 2025-10-27 10:27:34.837 2729 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-27T10:27:32.900565Z ]
node0 7m 7.629s 2025-10-27 10:27:34.839 2730 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:32.900565Z ]
node0 7m 7.635s 2025-10-27 10:27:34.845 2731 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 7m 7.636s 2025-10-27 10:27:34.846 2732 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 7m 7.636s 2025-10-27 10:27:34.846 2733 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Waiting for final state to save before terminating
node1 7m 7.677s 2025-10-27 10:27:34.887 2735 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900565Z ]
node1 7m 7.677s 2025-10-27 10:27:34.887 2736 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:32.900565Z,type=EXIT_VALIDATION]
node1 7m 7.678s 2025-10-27 10:27:34.888 2737 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-27T10:27:32.900565Z ]
node1 7m 7.679s 2025-10-27 10:27:34.889 2738 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:32.900565Z ]
node1 7m 7.679s 2025-10-27 10:27:34.889 2739 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 7.744s 2025-10-27 10:27:34.954 2735 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900565Z ]
node2 7m 7.745s 2025-10-27 10:27:34.955 2736 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:32.900565Z,type=EXIT_VALIDATION]
node2 7m 7.745s 2025-10-27 10:27:34.955 2737 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-27T10:27:32.900565Z ]
node2 7m 7.747s 2025-10-27 10:27:34.957 2738 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:32.900565Z ]
node2 7m 7.747s 2025-10-27 10:27:34.957 2739 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Waiting for final state to save before terminating
node3 7m 7.852s 2025-10-27 10:27:35.062 2735 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-27T10:27:32.900565Z ]
node3 7m 7.853s 2025-10-27 10:27:35.063 2736 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-27T10:27:32.900565Z,type=EXIT_VALIDATION]
node3 7m 7.853s 2025-10-27 10:27:35.063 2737 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-27T10:27:32.900565Z ]
node3 7m 7.855s 2025-10-27 10:27:35.065 2738 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-27T10:27:32.900565Z ]
node3 7m 7.855s 2025-10-27 10:27:35.065 2739 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Waiting for final state to save before terminating
node3 7m 9.499s 2025-10-27 10:27:36.709 2744 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761560914
3101 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-27T10:28:34.279056Z
node0 7m 9.552s 2025-10-27 10:27:36.762 2746 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761560914
node1 7m 9.592s 2025-10-27 10:27:36.802 2744 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761560914
node2 7m 9.663s 2025-10-27 10:27:36.873 2752 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761560914
node2 8m 8.405s 2025-10-27 10:28:35.615 3101 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 708 consensusTimeStamp: 2025-10-27T10:28:34.279056Z
node2 8m 8.406s 2025-10-27 10:28:35.616 3102 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-27T10:28:34.279056Z
node2 8m 8.406s 2025-10-27 10:28:35.616 3103 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node2 8m 8.407s 2025-10-27 10:28:35.617 3104 TRACE DEMO_INFO <platformForkJoinThread-8> PlatformTestingToolMain: ENTERING FREEZING!
node2 8m 8.408s 2025-10-27 10:28:35.618 3107 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 708 created, will eventually be written to disk, for reason: FREEZE_STATE
node2 8m 8.408s 2025-10-27 10:28:35.618 3108 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
node2 8m 8.408s 2025-10-27 10:28:35.618 3109 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change FREEZING
node2 8m 8.410s 2025-10-27 10:28:35.620 3112 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 708 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node2 8m 8.410s 2025-10-27 10:28:35.620 3113 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 708 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/708
node2 8m 8.411s 2025-10-27 10:28:35.621 3114 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 708
node2 8m 8.435s 2025-10-27 10:28:35.645 3125 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 8m 8.477s 2025-10-27 10:28:35.687 3103 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 708 consensusTimeStamp: 2025-10-27T10:28:34.279056Z
node0 8m 8.477s 2025-10-27 10:28:35.687 3104 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-27T10:28:34.279056Z
node3 8m 8.477s 2025-10-27 10:28:35.687 3102 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 708 consensusTimeStamp: 2025-10-27T10:28:34.279056Z
node0 8m 8.478s 2025-10-27 10:28:35.688 3105 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node3 8m 8.478s 2025-10-27 10:28:35.688 3103 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node3 8m 8.478s 2025-10-27 10:28:35.688 3104 TRACE DEMO_INFO <platformForkJoinThread-7> PlatformTestingToolMain: ENTERING FREEZING!
node0 8m 8.479s 2025-10-27 10:28:35.689 3106 TRACE DEMO_INFO <platformForkJoinThread-3> PlatformTestingToolMain: ENTERING FREEZING!
node0 8m 8.479s 2025-10-27 10:28:35.689 3109 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 708 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 8m 8.479s 2025-10-27 10:28:35.689 3110 TRACE DEMO_INFO <platformForkJoinThread-3> 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 8.479s 2025-10-27 10:28:35.689 3111 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change FREEZING
node3 8m 8.479s 2025-10-27 10:28:35.689 3105 TRACE DEMO_INFO <platformForkJoinThread-7> 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 8.479s 2025-10-27 10:28:35.689 3107 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change FREEZING
node3 8m 8.479s 2025-10-27 10:28:35.689 3109 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 708 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 8m 8.481s 2025-10-27 10:28:35.691 3114 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 708 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node0 8m 8.482s 2025-10-27 10:28:35.692 3115 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 708 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/708
node0 8m 8.482s 2025-10-27 10:28:35.692 3116 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 708
node3 8m 8.482s 2025-10-27 10:28:35.692 3112 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 708 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node3 8m 8.482s 2025-10-27 10:28:35.692 3113 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 708 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/708
node3 8m 8.482s 2025-10-27 10:28:35.692 3114 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 708
node3 8m 8.507s 2025-10-27 10:28:35.717 3125 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 8m 8.512s 2025-10-27 10:28:35.722 3127 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node1 8m 8.609s 2025-10-27 10:28:35.819 3101 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 708 consensusTimeStamp: 2025-10-27T10:28:34.279056Z
node1 8m 8.610s 2025-10-27 10:28:35.820 3102 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-10-27T10:28:34.279056Z
node1 8m 8.610s 2025-10-27 10:28:35.820 3103 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node1 8m 8.611s 2025-10-27 10:28:35.821 3105 TRACE DEMO_INFO <platformForkJoinThread-8> PlatformTestingToolMain: ENTERING FREEZING!
node1 8m 8.611s 2025-10-27 10:28:35.821 3107 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 708 created, will eventually be written to disk, for reason: FREEZE_STATE
node1 8m 8.611s 2025-10-27 10:28:35.821 3108 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 8.611s 2025-10-27 10:28:35.821 3109 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change FREEZING
node1 8m 8.613s 2025-10-27 10:28:35.823 3112 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 708 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node1 8m 8.615s 2025-10-27 10:28:35.825 3113 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 708 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/708
node1 8m 8.615s 2025-10-27 10:28:35.825 3114 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 708
node1 8m 8.640s 2025-10-27 10:28:35.850 3125 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 10.844s 2025-10-27 10:28:38.054 3176 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 708
node2 8m 10.846s 2025-10-27 10:28:38.056 3177 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 708 Timestamp: 2025-10-27T10:28:34.279056Z Next consensus number: 12148 Legacy running event hash: fbf532ad76f7072926fc1c2777df7a4af5edaeede60fc3e235f8e52a393a03c7713c0df5e2c3e742d0b499202ec3d541 Legacy running event mnemonic: lift-fiber-ten-topple Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1582421942 Root hash: 796d1891f750d4f73cdb9b740697415784b3422c5fea8ee8e8da72d1c879ebff2ab34c25fb1525f2f36fcbaf2a15ae28 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 / color-banana-bid-gentle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 globe-carry-total-hurdle 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 also-print-side-tip 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 8m 10.857s 2025-10-27 10:28:38.067 3178 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/2/2025/10/27/2025-10-27T10+21+14.422093357Z_seq5_minr18_maxr54_orgn0.pces Last file: data/saved/preconsensus-events/2/2025/10/27/2025-10-27T10+21+35.142424569Z_seq8_minr50_maxr93_orgn0.pces
node2 8m 10.858s 2025-10-27 10:28:38.068 3179 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 681 File: data/saved/preconsensus-events/2/2025/10/27/2025-10-27T10+28+16.111489328Z_seq39_minr651_maxr713_orgn0.pces
node2 8m 10.858s 2025-10-27 10:28:38.068 3180 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 8m 10.858s 2025-10-27 10:28:38.068 3181 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 8m 10.859s 2025-10-27 10:28:38.069 3182 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 708 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/708 {"round":708,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/708/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 8m 10.860s 2025-10-27 10:28:38.070 3183 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-27T10:28:34.279056Z ]
node2 8m 10.861s 2025-10-27 10:28:38.071 3184 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 2.5 s in FREEZING. Now in FREEZE_COMPLETE
node2 8m 10.861s 2025-10-27 10:28:38.071 3185 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node2 8m 10.862s 2025-10-27 10:28:38.072 3186 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-27T10:28:34.279056Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 8m 10.950s 2025-10-27 10:28:38.160 3176 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 708
node3 8m 10.952s 2025-10-27 10:28:38.162 3177 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 708 Timestamp: 2025-10-27T10:28:34.279056Z Next consensus number: 12148 Legacy running event hash: fbf532ad76f7072926fc1c2777df7a4af5edaeede60fc3e235f8e52a393a03c7713c0df5e2c3e742d0b499202ec3d541 Legacy running event mnemonic: lift-fiber-ten-topple Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1582421942 Root hash: 796d1891f750d4f73cdb9b740697415784b3422c5fea8ee8e8da72d1c879ebff2ab34c25fb1525f2f36fcbaf2a15ae28 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 / color-banana-bid-gentle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 globe-carry-total-hurdle 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 also-print-side-tip 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 8m 10.963s 2025-10-27 10:28:38.173 3178 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/3/2025/10/27/2025-10-27T10+23+09.864672990Z_seq16_minr197_maxr244_orgn0.pces Last file: data/saved/preconsensus-events/3/2025/10/27/2025-10-27T10+24+23.984185109Z_seq22_minr316_maxr361_orgn0.pces
node3 8m 10.963s 2025-10-27 10:28:38.173 3179 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 681 First file to copy: data/saved/preconsensus-events/3/2025/10/27/2025-10-27T10+28+12.704692055Z_seq39_minr646_maxr707_orgn0.pces Last file to copy: data/saved/preconsensus-events/3/2025/10/27/2025-10-27T10+28+35.313993703Z_seq40_minr680_maxr744_orgn0.pces
node3 8m 10.963s 2025-10-27 10:28:38.173 3180 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node3 8m 10.964s 2025-10-27 10:28:38.174 3181 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node3 8m 10.964s 2025-10-27 10:28:38.174 3182 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 708 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/708 {"round":708,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/708/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 8m 10.965s 2025-10-27 10:28:38.175 3183 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-27T10:28:34.279056Z ]
node3 8m 10.966s 2025-10-27 10:28:38.176 3184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.5 s in FREEZING. Now in FREEZE_COMPLETE
node3 8m 10.967s 2025-10-27 10:28:38.177 3185 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-27T10:28:34.279056Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 8m 10.967s 2025-10-27 10:28:38.177 3186 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 8m 11.421s 2025-10-27 10:28:38.631 3178 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 708
node0 8m 11.424s 2025-10-27 10:28:38.634 3179 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 708 Timestamp: 2025-10-27T10:28:34.279056Z Next consensus number: 12148 Legacy running event hash: fbf532ad76f7072926fc1c2777df7a4af5edaeede60fc3e235f8e52a393a03c7713c0df5e2c3e742d0b499202ec3d541 Legacy running event mnemonic: lift-fiber-ten-topple Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1582421942 Root hash: 796d1891f750d4f73cdb9b740697415784b3422c5fea8ee8e8da72d1c879ebff2ab34c25fb1525f2f36fcbaf2a15ae28 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 / color-banana-bid-gentle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 globe-carry-total-hurdle 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 also-print-side-tip 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 8m 11.441s 2025-10-27 10:28:38.651 3180 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/0/2025/10/27/2025-10-27T10+25+52.138957369Z_seq29_minr441_maxr486_orgn0.pces Last file: data/saved/preconsensus-events/0/2025/10/27/2025-10-27T10+28+16.103069051Z_seq39_minr651_maxr712_orgn0.pces
node0 8m 11.442s 2025-10-27 10:28:38.652 3181 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 681 File: data/saved/preconsensus-events/0/2025/10/27/2025-10-27T10+28+16.103069051Z_seq39_minr651_maxr712_orgn0.pces
node0 8m 11.442s 2025-10-27 10:28:38.652 3182 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 8m 11.443s 2025-10-27 10:28:38.653 3183 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 8m 11.444s 2025-10-27 10:28:38.654 3184 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 708 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/708 {"round":708,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/708/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 8m 11.445s 2025-10-27 10:28:38.655 3185 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-27T10:28:34.279056Z ]
node0 8m 11.446s 2025-10-27 10:28:38.656 3186 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 s in FREEZING. Now in FREEZE_COMPLETE
node0 8m 11.446s 2025-10-27 10:28:38.656 3187 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 8m 11.448s 2025-10-27 10:28:38.658 3188 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-27T10:28:34.279056Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 8m 11.518s 2025-10-27 10:28:38.728 3176 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 708
node1 8m 11.523s 2025-10-27 10:28:38.733 3177 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 708 Timestamp: 2025-10-27T10:28:34.279056Z Next consensus number: 12148 Legacy running event hash: fbf532ad76f7072926fc1c2777df7a4af5edaeede60fc3e235f8e52a393a03c7713c0df5e2c3e742d0b499202ec3d541 Legacy running event mnemonic: lift-fiber-ten-topple Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1582421942 Root hash: 796d1891f750d4f73cdb9b740697415784b3422c5fea8ee8e8da72d1c879ebff2ab34c25fb1525f2f36fcbaf2a15ae28 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 / color-banana-bid-gentle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 globe-carry-total-hurdle 1 VirtualMap RosterService.ROSTERS /1 castle-fabric-dismiss-act 2 SingletonNode RosterService.ROSTER_STATE /2 question-virtual-denial-sweet 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 also-print-side-tip 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 8m 11.538s 2025-10-27 10:28:38.748 3178 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/1/2025/10/27/2025-10-27T10+25+51.784595877Z_seq29_minr440_maxr485_orgn0.pces Last file: data/saved/preconsensus-events/1/2025/10/27/2025-10-27T10+26+04.213851388Z_seq30_minr457_maxr503_orgn0.pces
node1 8m 11.539s 2025-10-27 10:28:38.749 3179 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 681 File: data/saved/preconsensus-events/1/2025/10/27/2025-10-27T10+28+14.754614264Z_seq39_minr649_maxr710_orgn0.pces
node1 8m 11.539s 2025-10-27 10:28:38.749 3180 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 8m 11.539s 2025-10-27 10:28:38.749 3181 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 8m 11.540s 2025-10-27 10:28:38.750 3182 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 708 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/708 {"round":708,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/708/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node1 8m 11.542s 2025-10-27 10:28:38.752 3183 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-27T10:28:34.279056Z ]
node1 8m 11.543s 2025-10-27 10:28:38.753 3184 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 2.9 s in FREEZING. Now in FREEZE_COMPLETE
node1 8m 11.544s 2025-10-27 10:28:38.754 3185 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node1 8m 11.545s 2025-10-27 10:28:38.755 3186 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-27T10:28:34.279056Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 9m 14.075s 2025-10-27 10:29:41.285 3189 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 0 to 3>> NetworkUtils: Connection broken: 0 -> 3
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.282795271Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:245) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.282795271Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:159) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:444) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:199) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:242) ... 6 more Caused by: java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:592) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:105) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:157) ... 10 more
node0 9m 14.084s 2025-10-27 10:29:41.294 3190 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 0 to 2>> NetworkUtils: Connection broken: 0 -> 2
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.293925250Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:245) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.293925250Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:159) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:444) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:382) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:245) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:242) ... 6 more Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:164) ... 11 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$sendEventsTheyNeed$8(SyncUtils.java:229) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 1 more Caused by: java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readEventsINeed$9(SyncUtils.java:273) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:157) ... 11 more
node0 9m 14.164s 2025-10-27 10:29:41.374 3191 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 0 to 1>> NetworkUtils: Connection broken: 0 -> 1
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.374395428Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:245) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-27T10:29:41.374395428Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:159) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:444) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:199) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:242) ... 6 more Caused by: java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:592) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:105) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:157) ... 10 more