Node ID






Columns











Log Level






Log Marker











Class














































node0 0.000ns 2025-10-22 11:02:25.185 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 87.000ms 2025-10-22 11:02:25.272 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 103.000ms 2025-10-22 11:02:25.288 3 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 104.000ms 2025-10-22 11:02:25.289 4 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 216.000ms 2025-10-22 11:02:25.401 5 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 222.000ms 2025-10-22 11:02:25.407 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 250.000ms 2025-10-22 11:02:25.435 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 251.000ms 2025-10-22 11:02:25.436 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 252.000ms 2025-10-22 11:02:25.437 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 252.000ms 2025-10-22 11:02:25.437 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 253.000ms 2025-10-22 11:02:25.438 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 253.000ms 2025-10-22 11:02:25.438 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 253.000ms 2025-10-22 11:02:25.438 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 254.000ms 2025-10-22 11:02:25.439 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 255.000ms 2025-10-22 11:02:25.440 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 255.000ms 2025-10-22 11:02:25.440 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 255.000ms 2025-10-22 11:02:25.440 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 256.000ms 2025-10-22 11:02:25.441 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 256.000ms 2025-10-22 11:02:25.441 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 257.000ms 2025-10-22 11:02:25.442 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 257.000ms 2025-10-22 11:02:25.442 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 441.000ms 2025-10-22 11:02:25.626 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 528.000ms 2025-10-22 11:02:25.713 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 544.000ms 2025-10-22 11:02:25.729 3 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 545.000ms 2025-10-22 11:02:25.730 4 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 654.000ms 2025-10-22 11:02:25.839 44 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 659.000ms 2025-10-22 11:02:25.844 5 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 666.000ms 2025-10-22 11:02:25.851 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 694.000ms 2025-10-22 11:02:25.879 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 695.000ms 2025-10-22 11:02:25.880 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 695.000ms 2025-10-22 11:02:25.880 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 696.000ms 2025-10-22 11:02:25.881 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 696.000ms 2025-10-22 11:02:25.881 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 697.000ms 2025-10-22 11:02:25.882 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 697.000ms 2025-10-22 11:02:25.882 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 698.000ms 2025-10-22 11:02:25.883 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 699.000ms 2025-10-22 11:02:25.884 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 699.000ms 2025-10-22 11:02:25.884 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 699.000ms 2025-10-22 11:02:25.884 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 700.000ms 2025-10-22 11:02:25.885 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 700.000ms 2025-10-22 11:02:25.885 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 700.000ms 2025-10-22 11:02:25.885 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 701.000ms 2025-10-22 11:02:25.886 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 1.103s 2025-10-22 11:02:26.288 44 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 1.351s 2025-10-22 11:02:26.536 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node3 1.440s 2025-10-22 11:02:26.625 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 1.456s 2025-10-22 11:02:26.641 3 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node3 1.457s 2025-10-22 11:02:26.642 4 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 1.500s 2025-10-22 11:02:26.685 45 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 844ms
node0 1.507s 2025-10-22 11:02:26.692 46 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 1.507s 2025-10-22 11:02:26.692 47 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 1.552s 2025-10-22 11:02:26.737 48 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 1.570s 2025-10-22 11:02:26.755 5 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 1.576s 2025-10-22 11:02:26.761 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 1.604s 2025-10-22 11:02:26.789 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.606s 2025-10-22 11:02:26.791 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.606s 2025-10-22 11:02:26.791 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.606s 2025-10-22 11:02:26.791 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.607s 2025-10-22 11:02:26.792 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.607s 2025-10-22 11:02:26.792 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.608s 2025-10-22 11:02:26.793 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.609s 2025-10-22 11:02:26.794 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.609s 2025-10-22 11:02:26.794 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.609s 2025-10-22 11:02:26.794 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.610s 2025-10-22 11:02:26.795 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.610s 2025-10-22 11:02:26.795 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.610s 2025-10-22 11:02:26.795 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.611s 2025-10-22 11:02:26.796 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.611s 2025-10-22 11:02:26.796 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 1.629s 2025-10-22 11:02:26.814 49 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 1.630s 2025-10-22 11:02:26.815 50 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 2.018s 2025-10-22 11:02:27.203 44 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 2.143s 2025-10-22 11:02:27.328 45 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1040ms
node2 2.150s 2025-10-22 11:02:27.335 46 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 2.151s 2025-10-22 11:02:27.336 47 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 2.191s 2025-10-22 11:02:27.376 48 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node2 2.261s 2025-10-22 11:02:27.446 49 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 2.262s 2025-10-22 11:02:27.447 50 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 2.724s 2025-10-22 11:02:27.909 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 2.824s 2025-10-22 11:02:28.009 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 2.843s 2025-10-22 11:02:28.028 3 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node1 2.844s 2025-10-22 11:02:28.029 4 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node3 2.916s 2025-10-22 11:02:28.101 45 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 896ms
node3 2.921s 2025-10-22 11:02:28.106 46 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node3 2.922s 2025-10-22 11:02:28.107 47 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node3 2.960s 2025-10-22 11:02:28.145 48 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 2.978s 2025-10-22 11:02:28.163 5 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node1 2.986s 2025-10-22 11:02:28.171 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node1 3.022s 2025-10-22 11:02:28.207 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 3.024s 2025-10-22 11:02:28.209 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 3.025s 2025-10-22 11:02:28.210 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 3.026s 2025-10-22 11:02:28.211 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 3.026s 2025-10-22 11:02:28.211 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 3.026s 2025-10-22 11:02:28.211 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 3.027s 2025-10-22 11:02:28.212 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 3.028s 2025-10-22 11:02:28.213 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 3.028s 2025-10-22 11:02:28.213 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 3.029s 2025-10-22 11:02:28.214 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 3.029s 2025-10-22 11:02:28.214 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 3.029s 2025-10-22 11:02:28.214 49 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 3.030s 2025-10-22 11:02:28.215 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 3.030s 2025-10-22 11:02:28.215 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 3.030s 2025-10-22 11:02:28.215 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 3.030s 2025-10-22 11:02:28.215 50 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 3.031s 2025-10-22 11:02:28.216 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 3.486s 2025-10-22 11:02:28.671 44 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node0 3.621s 2025-10-22 11:02:28.806 51 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 3.706s 2025-10-22 11:02:28.891 54 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 3.707s 2025-10-22 11:02:28.892 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 3.707s 2025-10-22 11:02:28.892 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 3.707s 2025-10-22 11:02:28.892 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 3.708s 2025-10-22 11:02:28.893 58 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 3.708s 2025-10-22 11:02:28.893 59 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 3.708s 2025-10-22 11:02:28.893 60 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 3.709s 2025-10-22 11:02:28.894 61 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 3.713s 2025-10-22 11:02:28.898 69 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 3.716s 2025-10-22 11:02:28.901 70 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 3.717s 2025-10-22 11:02:28.902 71 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@65ec8b24
node2 4.278s 2025-10-22 11:02:29.463 51 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 4.362s 2025-10-22 11:02:29.547 54 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 4.363s 2025-10-22 11:02:29.548 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 4.363s 2025-10-22 11:02:29.548 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 4.363s 2025-10-22 11:02:29.548 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 4.364s 2025-10-22 11:02:29.549 58 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 4.364s 2025-10-22 11:02:29.549 59 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 4.364s 2025-10-22 11:02:29.549 60 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 4.364s 2025-10-22 11:02:29.549 61 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 4.368s 2025-10-22 11:02:29.553 69 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.371s 2025-10-22 11:02:29.556 70 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 4.371s 2025-10-22 11:02:29.556 71 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@65ec8b24
node0 4.420s 2025-10-22 11:02:29.605 79 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 4.420s 2025-10-22 11:02:29.605 80 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 4.471s 2025-10-22 11:02:29.656 86 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node0 4.475s 2025-10-22 11:02:29.660 94 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 4.476s 2025-10-22 11:02:29.661 95 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 4.476s 2025-10-22 11:02:29.661 96 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node0 4.521s 2025-10-22 11:02:29.706 99 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 4.526s 2025-10-22 11:02:29.711 100 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 4.634s 2025-10-22 11:02:29.819 45 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1148ms
node1 4.641s 2025-10-22 11:02:29.826 46 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node1 4.642s 2025-10-22 11:02:29.827 47 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node1 4.688s 2025-10-22 11:02:29.873 48 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 4.763s 2025-10-22 11:02:29.948 49 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 4.764s 2025-10-22 11:02:29.949 50 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 5.087s 2025-10-22 11:02:30.272 51 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 5.093s 2025-10-22 11:02:30.278 79 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.094s 2025-10-22 11:02:30.279 80 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.146s 2025-10-22 11:02:30.331 86 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node2 5.150s 2025-10-22 11:02:30.335 94 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.151s 2025-10-22 11:02:30.336 95 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.152s 2025-10-22 11:02:30.337 96 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node3 5.169s 2025-10-22 11:02:30.354 54 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 5.171s 2025-10-22 11:02:30.356 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 5.171s 2025-10-22 11:02:30.356 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 5.172s 2025-10-22 11:02:30.357 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 5.172s 2025-10-22 11:02:30.357 58 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 5.172s 2025-10-22 11:02:30.357 59 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 5.173s 2025-10-22 11:02:30.358 60 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 5.173s 2025-10-22 11:02:30.358 61 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 5.176s 2025-10-22 11:02:30.361 69 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.180s 2025-10-22 11:02:30.365 70 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 5.180s 2025-10-22 11:02:30.365 71 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@65ec8b24
node2 5.196s 2025-10-22 11:02:30.381 99 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 5.201s 2025-10-22 11:02:30.386 100 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node0 5.640s 2025-10-22 11:02:30.825 101 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20991456] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=402140, randomLong=3454487369404896935, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=16460, randomLong=-2826667326160638278, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1272579, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms)
node0 5.667s 2025-10-22 11:02:30.852 102 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 5.675s 2025-10-22 11:02:30.860 103 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 5.679s 2025-10-22 11:02:30.864 104 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 5.759s 2025-10-22 11:02:30.944 105 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "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": "IqzoZQ==", "port": 30124 }, { "ipAddressV4": "CoAAZg==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "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": "I+BFCQ==", "port": 30125 }, { "ipAddressV4": "CoAANw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "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": "I+57xg==", "port": 30126 }, { "ipAddressV4": "CoAAaA==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "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": "IjilRQ==", "port": 30127 }, { "ipAddressV4": "CoAP4g==", "port": 30127 }] }] }
node0 5.854s 2025-10-22 11:02:31.039 106 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 5.854s 2025-10-22 11:02:31.039 107 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 5.856s 2025-10-22 11:02:31.041 115 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.857s 2025-10-22 11:02:31.042 116 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 5.857s 2025-10-22 11:02:31.042 117 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node0 5.860s 2025-10-22 11:02:31.045 125 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.860s 2025-10-22 11:02:31.045 126 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 5.861s 2025-10-22 11:02:31.046 127 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node0 5.863s 2025-10-22 11:02:31.048 135 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 5.864s 2025-10-22 11:02:31.049 136 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 5.864s 2025-10-22 11:02:31.049 137 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node0 5.878s 2025-10-22 11:02:31.063 138 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: 34585d125c2c65354d4fa4a8a76bd8eb9accc87654ec45c0485c95a3c202be3d1ad43dc214f8a8563ec51ce26b5e3daa 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 / mention-pelican-machine-pluck 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 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 5.891s 2025-10-22 11:02:31.076 79 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.892s 2025-10-22 11:02:31.077 80 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 5.951s 2025-10-22 11:02:31.136 86 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node3 5.957s 2025-10-22 11:02:31.142 94 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.957s 2025-10-22 11:02:31.142 95 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 5.958s 2025-10-22 11:02:31.143 96 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node3 6.003s 2025-10-22 11:02:31.188 99 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node3 6.008s 2025-10-22 11:02:31.193 100 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node0 6.093s 2025-10-22 11:02:31.278 140 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 6.097s 2025-10-22 11:02:31.282 141 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 6.106s 2025-10-22 11:02:31.291 142 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 6.107s 2025-10-22 11:02:31.292 143 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 6.107s 2025-10-22 11:02:31.292 144 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 6.107s 2025-10-22 11:02:31.292 145 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 6.107s 2025-10-22 11:02:31.292 146 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 6.107s 2025-10-22 11:02:31.292 147 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 6.108s 2025-10-22 11:02:31.293 148 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 6.108s 2025-10-22 11:02:31.293 149 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 6.108s 2025-10-22 11:02:31.293 150 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 6.108s 2025-10-22 11:02:31.293 151 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 6.109s 2025-10-22 11:02:31.294 152 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 6.109s 2025-10-22 11:02:31.294 153 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 6.109s 2025-10-22 11:02:31.294 154 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 6.110s 2025-10-22 11:02:31.295 155 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 6.110s 2025-10-22 11:02:31.295 156 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node0 6.132s 2025-10-22 11:02:31.317 157 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 6.132s 2025-10-22 11:02:31.317 158 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 6.133s 2025-10-22 11:02:31.318 159 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 6.133s 2025-10-22 11:02:31.318 160 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 6.133s 2025-10-22 11:02:31.318 161 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 6.134s 2025-10-22 11:02:31.319 162 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node0 6.135s 2025-10-22 11:02:31.320 163 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 6.136s 2025-10-22 11:02:31.321 164 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node0 6.143s 2025-10-22 11:02:31.328 165 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@6ac90300
node0 6.144s 2025-10-22 11:02:31.329 166 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 2400
node0 6.144s 2025-10-22 11:02:31.329 167 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node0 6.151s 2025-10-22 11:02:31.336 172 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@32d8348, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@42ce5f9a,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@308a9dc8,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1992d4ff,snapshotInProgress=false]
node0 6.159s 2025-10-22 11:02:31.344 173 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 6.160s 2025-10-22 11:02:31.345 174 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 6.165s 2025-10-22 11:02:31.350 175 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is 6027748594982311654
node0 6.165s 2025-10-22 11:02:31.350 176 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 6.243s 2025-10-22 11:02:31.428 177 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 6.245s 2025-10-22 11:02:31.430 178 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 6.248s 2025-10-22 11:02:31.433 179 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 6.249s 2025-10-22 11:02:31.434 180 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 6.249s 2025-10-22 11:02:31.434 181 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 6.251s 2025-10-22 11:02:31.436 182 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 6.251s 2025-10-22 11:02:31.436 183 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 6.252s 2025-10-22 11:02:31.437 184 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 6.253s 2025-10-22 11:02:31.438 185 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 6.254s 2025-10-22 11:02:31.439 186 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 323.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 6.258s 2025-10-22 11:02:31.443 187 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 6.259s 2025-10-22 11:02:31.444 188 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 6.259s 2025-10-22 11:02:31.444 189 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 6.342s 2025-10-22 11:02:31.527 101 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20834497] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=306990, randomLong=4497067966896751057, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=8880, randomLong=362304964153925350, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1452999, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms)
node2 6.373s 2025-10-22 11:02:31.558 102 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node2 6.380s 2025-10-22 11:02:31.565 103 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 6.385s 2025-10-22 11:02:31.570 104 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 6.467s 2025-10-22 11:02:31.652 105 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "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": "IqzoZQ==", "port": 30124 }, { "ipAddressV4": "CoAAZg==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "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": "I+BFCQ==", "port": 30125 }, { "ipAddressV4": "CoAANw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "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": "I+57xg==", "port": 30126 }, { "ipAddressV4": "CoAAaA==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "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": "IjilRQ==", "port": 30127 }, { "ipAddressV4": "CoAP4g==", "port": 30127 }] }] }
node2 6.564s 2025-10-22 11:02:31.749 106 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 6.565s 2025-10-22 11:02:31.750 107 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 6.567s 2025-10-22 11:02:31.752 115 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.567s 2025-10-22 11:02:31.752 116 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 6.568s 2025-10-22 11:02:31.753 117 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node2 6.571s 2025-10-22 11:02:31.756 125 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.571s 2025-10-22 11:02:31.756 126 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.571s 2025-10-22 11:02:31.756 127 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node2 6.574s 2025-10-22 11:02:31.759 135 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.574s 2025-10-22 11:02:31.759 136 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.575s 2025-10-22 11:02:31.760 137 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node2 6.590s 2025-10-22 11:02:31.775 138 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: 34585d125c2c65354d4fa4a8a76bd8eb9accc87654ec45c0485c95a3c202be3d1ad43dc214f8a8563ec51ce26b5e3daa 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 / mention-pelican-machine-pluck 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 6.787s 2025-10-22 11:02:31.972 140 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 6.792s 2025-10-22 11:02:31.977 141 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 6.800s 2025-10-22 11:02:31.985 142 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 6.801s 2025-10-22 11:02:31.986 143 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 6.801s 2025-10-22 11:02:31.986 144 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 6.801s 2025-10-22 11:02:31.986 145 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 6.801s 2025-10-22 11:02:31.986 146 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 6.801s 2025-10-22 11:02:31.986 147 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 6.802s 2025-10-22 11:02:31.987 148 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 6.802s 2025-10-22 11:02:31.987 149 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 6.802s 2025-10-22 11:02:31.987 150 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 6.802s 2025-10-22 11:02:31.987 151 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 6.802s 2025-10-22 11:02:31.987 152 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 6.803s 2025-10-22 11:02:31.988 153 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 6.803s 2025-10-22 11:02:31.988 154 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 6.803s 2025-10-22 11:02:31.988 155 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 6.804s 2025-10-22 11:02:31.989 156 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node2 6.821s 2025-10-22 11:02:32.006 157 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 6.821s 2025-10-22 11:02:32.006 158 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 6.821s 2025-10-22 11:02:32.006 159 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 6.821s 2025-10-22 11:02:32.006 160 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 6.822s 2025-10-22 11:02:32.007 161 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 6.822s 2025-10-22 11:02:32.007 162 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node2 6.823s 2025-10-22 11:02:32.008 163 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 6.824s 2025-10-22 11:02:32.009 164 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node2 6.830s 2025-10-22 11:02:32.015 165 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@4e128201
node2 6.831s 2025-10-22 11:02:32.016 166 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 2400
node2 6.831s 2025-10-22 11:02:32.016 167 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node2 6.838s 2025-10-22 11:02:32.023 172 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@20b6068e, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@42a57d3e,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@6bc92d5c,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@40c92b2f,snapshotInProgress=false]
node1 6.846s 2025-10-22 11:02:32.031 51 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 6.846s 2025-10-22 11:02:32.031 173 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 6.846s 2025-10-22 11:02:32.031 174 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 6.851s 2025-10-22 11:02:32.036 175 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is 3541426861926034953
node2 6.851s 2025-10-22 11:02:32.036 176 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 6.930s 2025-10-22 11:02:32.115 54 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 6.930s 2025-10-22 11:02:32.115 177 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node1 6.931s 2025-10-22 11:02:32.116 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 6.931s 2025-10-22 11:02:32.116 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 6.931s 2025-10-22 11:02:32.116 178 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 6.932s 2025-10-22 11:02:32.117 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 6.932s 2025-10-22 11:02:32.117 58 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 6.932s 2025-10-22 11:02:32.117 59 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 6.932s 2025-10-22 11:02:32.117 60 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 6.933s 2025-10-22 11:02:32.118 61 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 6.935s 2025-10-22 11:02:32.120 179 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 6.936s 2025-10-22 11:02:32.121 69 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.936s 2025-10-22 11:02:32.121 180 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 6.937s 2025-10-22 11:02:32.122 181 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 6.938s 2025-10-22 11:02:32.123 182 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node1 6.939s 2025-10-22 11:02:32.124 70 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 6.939s 2025-10-22 11:02:32.124 183 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 6.940s 2025-10-22 11:02:32.125 71 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@65ec8b24
node2 6.940s 2025-10-22 11:02:32.125 184 INFO STARTUP <<start-node-2>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node2 6.941s 2025-10-22 11:02:32.126 185 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 6.942s 2025-10-22 11:02:32.127 186 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 295.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 6.951s 2025-10-22 11:02:32.136 187 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 6.952s 2025-10-22 11:02:32.137 188 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 6.952s 2025-10-22 11:02:32.137 189 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change OBSERVING
node3 7.128s 2025-10-22 11:02:32.313 101 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20895318] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=208390, randomLong=-2817229886413457776, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=7060, randomLong=-7293578155713559167, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1200689, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms)
node3 7.156s 2025-10-22 11:02:32.341 102 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 7.163s 2025-10-22 11:02:32.348 103 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 7.168s 2025-10-22 11:02:32.353 104 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 7.247s 2025-10-22 11:02:32.432 105 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "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": "IqzoZQ==", "port": 30124 }, { "ipAddressV4": "CoAAZg==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "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": "I+BFCQ==", "port": 30125 }, { "ipAddressV4": "CoAANw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "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": "I+57xg==", "port": 30126 }, { "ipAddressV4": "CoAAaA==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "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": "IjilRQ==", "port": 30127 }, { "ipAddressV4": "CoAP4g==", "port": 30127 }] }] }
node3 7.343s 2025-10-22 11:02:32.528 106 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 7.343s 2025-10-22 11:02:32.528 107 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 7.345s 2025-10-22 11:02:32.530 115 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.346s 2025-10-22 11:02:32.531 116 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 7.346s 2025-10-22 11:02:32.531 117 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node3 7.349s 2025-10-22 11:02:32.534 125 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.349s 2025-10-22 11:02:32.534 126 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 7.349s 2025-10-22 11:02:32.534 127 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node3 7.351s 2025-10-22 11:02:32.536 135 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.352s 2025-10-22 11:02:32.537 136 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 7.353s 2025-10-22 11:02:32.538 137 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node3 7.367s 2025-10-22 11:02:32.552 138 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: 34585d125c2c65354d4fa4a8a76bd8eb9accc87654ec45c0485c95a3c202be3d1ad43dc214f8a8563ec51ce26b5e3daa 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 / mention-pelican-machine-pluck 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 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 7.554s 2025-10-22 11:02:32.739 140 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 7.558s 2025-10-22 11:02:32.743 141 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 7.566s 2025-10-22 11:02:32.751 142 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 7.567s 2025-10-22 11:02:32.752 143 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 7.567s 2025-10-22 11:02:32.752 144 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 7.567s 2025-10-22 11:02:32.752 145 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 7.567s 2025-10-22 11:02:32.752 146 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 7.568s 2025-10-22 11:02:32.753 147 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 7.568s 2025-10-22 11:02:32.753 148 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 7.568s 2025-10-22 11:02:32.753 149 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 7.568s 2025-10-22 11:02:32.753 150 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 7.568s 2025-10-22 11:02:32.753 151 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 7.569s 2025-10-22 11:02:32.754 152 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 7.569s 2025-10-22 11:02:32.754 153 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 7.569s 2025-10-22 11:02:32.754 154 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 7.569s 2025-10-22 11:02:32.754 155 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 7.570s 2025-10-22 11:02:32.755 156 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node3 7.586s 2025-10-22 11:02:32.771 157 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 7.586s 2025-10-22 11:02:32.771 158 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 7.587s 2025-10-22 11:02:32.772 159 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 7.587s 2025-10-22 11:02:32.772 160 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 7.587s 2025-10-22 11:02:32.772 161 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 7.588s 2025-10-22 11:02:32.773 162 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node3 7.588s 2025-10-22 11:02:32.773 163 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 7.589s 2025-10-22 11:02:32.774 164 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node3 7.595s 2025-10-22 11:02:32.780 165 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@14ee0166
node3 7.596s 2025-10-22 11:02:32.781 166 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 2400
node3 7.596s 2025-10-22 11:02:32.781 167 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node3 7.603s 2025-10-22 11:02:32.788 172 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@2f0741ee, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@192a5089,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@57ef53b8,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2a468214,snapshotInProgress=false]
node3 7.611s 2025-10-22 11:02:32.796 173 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 7.611s 2025-10-22 11:02:32.796 174 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 7.616s 2025-10-22 11:02:32.801 175 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is 3654284310527636230
node3 7.616s 2025-10-22 11:02:32.801 176 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 7.684s 2025-10-22 11:02:32.869 79 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.685s 2025-10-22 11:02:32.870 80 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 7.693s 2025-10-22 11:02:32.878 177 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 7.695s 2025-10-22 11:02:32.880 178 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 7.698s 2025-10-22 11:02:32.883 179 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 7.699s 2025-10-22 11:02:32.884 180 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 7.700s 2025-10-22 11:02:32.885 181 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 7.702s 2025-10-22 11:02:32.887 182 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 7.702s 2025-10-22 11:02:32.887 183 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 7.703s 2025-10-22 11:02:32.888 184 INFO STARTUP <<start-node-3>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node3 7.704s 2025-10-22 11:02:32.889 185 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 7.704s 2025-10-22 11:02:32.889 186 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 283.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 7.707s 2025-10-22 11:02:32.892 187 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 7.708s 2025-10-22 11:02:32.893 188 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 7.708s 2025-10-22 11:02:32.893 189 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 7.744s 2025-10-22 11:02:32.929 86 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node1 7.750s 2025-10-22 11:02:32.935 94 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 7.751s 2025-10-22 11:02:32.936 95 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 7.751s 2025-10-22 11:02:32.936 96 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node1 7.801s 2025-10-22 11:02:32.986 99 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 7.807s 2025-10-22 11:02:32.992 100 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 8.932s 2025-10-22 11:02:34.117 101 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20890292] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=303590, randomLong=1658156951501903304, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=32120, randomLong=-4467541579632600873, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1760321, data=35, exception=null] OS Health Check Report - Complete (took 1025 ms)
node1 8.968s 2025-10-22 11:02:34.153 102 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 8.978s 2025-10-22 11:02:34.163 103 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 8.984s 2025-10-22 11:02:34.169 104 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node1 9.081s 2025-10-22 11:02:34.266 105 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "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": "IqzoZQ==", "port": 30124 }, { "ipAddressV4": "CoAAZg==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "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": "I+BFCQ==", "port": 30125 }, { "ipAddressV4": "CoAANw==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "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": "I+57xg==", "port": 30126 }, { "ipAddressV4": "CoAAaA==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "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": "IjilRQ==", "port": 30127 }, { "ipAddressV4": "CoAP4g==", "port": 30127 }] }] }
node0 9.113s 2025-10-22 11:02:34.298 190 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 9.116s 2025-10-22 11:02:34.301 191 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 9.189s 2025-10-22 11:02:34.374 106 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 9.190s 2025-10-22 11:02:34.375 107 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 9.192s 2025-10-22 11:02:34.377 115 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 9.192s 2025-10-22 11:02:34.377 116 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 9.193s 2025-10-22 11:02:34.378 117 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node1 9.196s 2025-10-22 11:02:34.381 125 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 9.196s 2025-10-22 11:02:34.381 126 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 9.197s 2025-10-22 11:02:34.382 127 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node1 9.199s 2025-10-22 11:02:34.384 135 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 9.200s 2025-10-22 11:02:34.385 136 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 9.201s 2025-10-22 11:02:34.386 137 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node1 9.217s 2025-10-22 11:02:34.402 138 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: 34585d125c2c65354d4fa4a8a76bd8eb9accc87654ec45c0485c95a3c202be3d1ad43dc214f8a8563ec51ce26b5e3daa 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 / mention-pelican-machine-pluck 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 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 9.460s 2025-10-22 11:02:34.645 140 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 9.467s 2025-10-22 11:02:34.652 141 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 9.482s 2025-10-22 11:02:34.667 142 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 9.483s 2025-10-22 11:02:34.668 143 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 9.484s 2025-10-22 11:02:34.669 144 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 9.484s 2025-10-22 11:02:34.669 145 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 9.484s 2025-10-22 11:02:34.669 146 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 9.485s 2025-10-22 11:02:34.670 147 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 9.485s 2025-10-22 11:02:34.670 148 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 9.485s 2025-10-22 11:02:34.670 149 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 9.486s 2025-10-22 11:02:34.671 150 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 9.486s 2025-10-22 11:02:34.671 151 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 9.486s 2025-10-22 11:02:34.671 152 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 9.487s 2025-10-22 11:02:34.672 153 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 9.488s 2025-10-22 11:02:34.673 154 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 9.488s 2025-10-22 11:02:34.673 155 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 9.488s 2025-10-22 11:02:34.673 156 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node1 9.513s 2025-10-22 11:02:34.698 157 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 9.519s 2025-10-22 11:02:34.704 158 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 9.521s 2025-10-22 11:02:34.706 159 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 9.522s 2025-10-22 11:02:34.707 160 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 9.522s 2025-10-22 11:02:34.707 161 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 9.523s 2025-10-22 11:02:34.708 162 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node1 9.525s 2025-10-22 11:02:34.710 163 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 9.529s 2025-10-22 11:02:34.714 164 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node1 9.539s 2025-10-22 11:02:34.724 165 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@4e128201
node1 9.541s 2025-10-22 11:02:34.726 166 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 2400
node1 9.542s 2025-10-22 11:02:34.727 167 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node1 9.555s 2025-10-22 11:02:34.740 172 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@20b6068e, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@42a57d3e,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@6bc92d5c,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@40c92b2f,snapshotInProgress=false]
node1 9.571s 2025-10-22 11:02:34.756 173 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 9.573s 2025-10-22 11:02:34.758 174 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 9.584s 2025-10-22 11:02:34.769 175 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is 1387800928776375414
node1 9.586s 2025-10-22 11:02:34.771 176 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 9.695s 2025-10-22 11:02:34.880 177 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 9.697s 2025-10-22 11:02:34.882 178 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 9.703s 2025-10-22 11:02:34.888 179 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 9.704s 2025-10-22 11:02:34.889 180 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 9.705s 2025-10-22 11:02:34.890 181 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 9.708s 2025-10-22 11:02:34.893 182 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 9.709s 2025-10-22 11:02:34.894 183 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 9.711s 2025-10-22 11:02:34.896 184 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 9.712s 2025-10-22 11:02:34.897 185 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 9.714s 2025-10-22 11:02:34.899 186 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 435.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 9.718s 2025-10-22 11:02:34.903 187 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 9.719s 2025-10-22 11:02:34.904 188 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 9.719s 2025-10-22 11:02:34.904 189 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 9.808s 2025-10-22 11:02:34.993 190 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 9.810s 2025-10-22 11:02:34.995 191 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 10.577s 2025-10-22 11:02:35.762 190 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ]
node3 10.579s 2025-10-22 11:02:35.764 191 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 12.488s 2025-10-22 11:02:37.673 190 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 12.493s 2025-10-22 11:02:37.678 191 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 16.351s 2025-10-22 11:02:41.536 192 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 16.351s 2025-10-22 11:02:41.536 193 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node2 17.037s 2025-10-22 11:02:42.222 192 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 17.038s 2025-10-22 11:02:42.223 193 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node3 17.801s 2025-10-22 11:02:42.986 192 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 17.801s 2025-10-22 11:02:42.986 193 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node2 19.054s 2025-10-22 11:02:44.239 194 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 19.162s 2025-10-22 11:02:44.347 192 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 19.371s 2025-10-22 11:02:44.556 194 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 19.595s 2025-10-22 11:02:44.780 195 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 3.2 s in CHECKING. Now in ACTIVE
node0 19.595s 2025-10-22 11:02:44.780 194 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 19.596s 2025-10-22 11:02:44.781 196 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 19.663s 2025-10-22 11:02:44.848 197 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x24FE33EDA24A94C5E1B5C17A44C1C4E9B9AEE7B01A970056B1A67A45B2D3CF9D', privateKey ='0x24FE33EDA24A94C5E1B5C17A44C1C4E9B9AEE7B01A970056B1A67A45B2D3CF9D', signature = '0x316DF79E21BE5AD1651BFC5ABFDB5B2D0655B4904D64DCFA6B67E1A4CE5D1145811E037E1D53D3F26DD284CA8E807E7D700678B86B52C64123ABDE67063AE402',message = '0x12660A0A4096D293FFB689CDBC21325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' }
node1 19.808s 2025-10-22 11:02:44.993 193 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 19.809s 2025-10-22 11:02:44.994 194 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change CHECKING
node2 20.086s 2025-10-22 11:02:45.271 195 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 3.0 s in CHECKING. Now in ACTIVE
node2 20.086s 2025-10-22 11:02:45.271 196 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 20.090s 2025-10-22 11:02:45.275 195 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.3 s in CHECKING. Now in ACTIVE
node3 20.090s 2025-10-22 11:02:45.275 196 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 20.169s 2025-10-22 11:02:45.354 197 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x1E96E9A9E89DCDDF4ABDE70FF1A33EB68B460109744C7F1DF20CA8DB3AC3C934', privateKey ='0x1E96E9A9E89DCDDF4ABDE70FF1A33EB68B460109744C7F1DF20CA8DB3AC3C934', signature = '0xDC00372C2CA2F1256AB7B28524A46A7ECB8CB1FACCEEF731A4146B24DA4E5606938E715DBB67A4B3FAE72E314E6B3313A00B53C6DA51158886DB58DFA708350E',message = '0x12660A1A0803100318A03820A03828A03830A03840EBAFB0E387EDC7EF243244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' }
node2 20.171s 2025-10-22 11:02:45.356 197 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xD3CD083E0FA63974F8F479AF65348F9EFD05251B653C04A1182455BC1EF1D0BB', privateKey ='0xD3CD083E0FA63974F8F479AF65348F9EFD05251B653C04A1182455BC1EF1D0BB', signature = '0x59E2C6CEEB5215F4FD80C8D9257D1528C83FD18CF13FAE99E41ACA7E5A49559539FF7E1573A77B72A0CE44CAD27576B8B5FD11DADC72C86AB59277EF94DFF60C',message = '0x1A6B0A1B08021002180120A18D0628914E30914E40CBD2C5FEBCA682A987012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' }
node2 20.818s 2025-10-22 11:02:46.003 200 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 20.873s 2025-10-22 11:02:46.058 200 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 20.968s 2025-10-22 11:02:46.153 197 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node3 20.993s 2025-10-22 11:02:46.178 200 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.314s 2025-10-22 11:02:46.499 209 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3
node0 21.316s 2025-10-22 11:02:46.501 210 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 21.361s 2025-10-22 11:02:46.546 209 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3
node3 21.363s 2025-10-22 11:02:46.548 210 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.382s 2025-10-22 11:02:46.567 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3
node1 21.384s 2025-10-22 11:02:46.569 207 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.399s 2025-10-22 11:02:46.584 216 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 1.6 s in CHECKING. Now in ACTIVE
node1 21.400s 2025-10-22 11:02:46.585 217 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 21.464s 2025-10-22 11:02:46.649 221 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x051D70C1456D4BC8D694CB77FDAB15E7C14F8967375031AC88ADBDDF5A89EFD3', privateKey ='0x051D70C1456D4BC8D694CB77FDAB15E7C14F8967375031AC88ADBDDF5A89EFD3', signature = '0x6C856EF34C050E4CA7A12F87DE1A54080824697DA2F526ED6D9EEFECA33856FC2A4C6F6A55C77E37F41E61EE1CADFC35C3F9675AA118523FB83ABBAAC6764F0D',message = '0x12660A1A0801100118E01220E01228E01230E01240FACD86A2BCAFAFC53C3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038014001' }
node2 21.554s 2025-10-22 11:02:46.739 209 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3
node2 21.556s 2025-10-22 11:02:46.741 210 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 21.581s 2025-10-22 11:02:46.766 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 21.584s 2025-10-22 11:02:46.769 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-22T11:02:44.775606Z Next consensus number: 14 Legacy running event hash: 9c7f89949febf80fe2da632dd0363594ddcfccefb6367173498af3c0e5d2da3de7805f88ad7aa9ee2553f599c4ed749f Legacy running event mnemonic: ice-snow-actor-wreck Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5f3f0a58bddb2fba3c7e62ce0b3a2c672a326bf36160c485bdc5a0e27042c609a239aa1e05dfc1fe1d7a68a04996217e 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 / tree-enrich-dwarf-warrior 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 lizard-favorite-bone-model 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 21.620s 2025-10-22 11:02:46.805 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/10/22/2025-10-22T11+02+41.571470518Z_seq0_minr1_maxr501_orgn0.pces
node0 21.621s 2025-10-22 11:02:46.806 262 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/22/2025-10-22T11+02+41.571470518Z_seq0_minr1_maxr501_orgn0.pces
node0 21.621s 2025-10-22 11:02:46.806 263 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 21.622s 2025-10-22 11:02:46.807 264 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 21.626s 2025-10-22 11:02:46.811 265 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 21.632s 2025-10-22 11:02:46.817 259 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 21.637s 2025-10-22 11:02:46.822 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-22T11:02:44.775606Z Next consensus number: 14 Legacy running event hash: 9c7f89949febf80fe2da632dd0363594ddcfccefb6367173498af3c0e5d2da3de7805f88ad7aa9ee2553f599c4ed749f Legacy running event mnemonic: ice-snow-actor-wreck Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5f3f0a58bddb2fba3c7e62ce0b3a2c672a326bf36160c485bdc5a0e27042c609a239aa1e05dfc1fe1d7a68a04996217e 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 / tree-enrich-dwarf-warrior 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 lizard-favorite-bone-model 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 21.671s 2025-10-22 11:02:46.856 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/10/22/2025-10-22T11+02+42.028481552Z_seq0_minr1_maxr501_orgn0.pces
node3 21.672s 2025-10-22 11:02:46.857 262 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/22/2025-10-22T11+02+42.028481552Z_seq0_minr1_maxr501_orgn0.pces
node3 21.672s 2025-10-22 11:02:46.857 263 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 21.673s 2025-10-22 11:02:46.858 264 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 21.679s 2025-10-22 11:02:46.864 265 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 21.680s 2025-10-22 11:02:46.865 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 21.684s 2025-10-22 11:02:46.869 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-22T11:02:44.775606Z Next consensus number: 14 Legacy running event hash: 9c7f89949febf80fe2da632dd0363594ddcfccefb6367173498af3c0e5d2da3de7805f88ad7aa9ee2553f599c4ed749f Legacy running event mnemonic: ice-snow-actor-wreck Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5f3f0a58bddb2fba3c7e62ce0b3a2c672a326bf36160c485bdc5a0e27042c609a239aa1e05dfc1fe1d7a68a04996217e 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 / tree-enrich-dwarf-warrior 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 lizard-favorite-bone-model 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 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 21.722s 2025-10-22 11:02:46.907 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/10/22/2025-10-22T11+02+41.770560973Z_seq0_minr1_maxr501_orgn0.pces
node1 21.723s 2025-10-22 11:02:46.908 262 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/22/2025-10-22T11+02+41.770560973Z_seq0_minr1_maxr501_orgn0.pces
node1 21.723s 2025-10-22 11:02:46.908 263 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 21.724s 2025-10-22 11:02:46.909 264 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 21.729s 2025-10-22 11:02:46.914 265 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 21.818s 2025-10-22 11:02:47.003 259 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 21.822s 2025-10-22 11:02:47.007 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-22T11:02:44.775606Z Next consensus number: 14 Legacy running event hash: 9c7f89949febf80fe2da632dd0363594ddcfccefb6367173498af3c0e5d2da3de7805f88ad7aa9ee2553f599c4ed749f Legacy running event mnemonic: ice-snow-actor-wreck Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5f3f0a58bddb2fba3c7e62ce0b3a2c672a326bf36160c485bdc5a0e27042c609a239aa1e05dfc1fe1d7a68a04996217e 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 / tree-enrich-dwarf-warrior 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 lizard-favorite-bone-model 1 VirtualMap RosterService.ROSTERS /1 proud-ladder-method-odor 2 SingletonNode RosterService.ROSTER_STATE /2 beach-ring-fit-between 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 21.858s 2025-10-22 11:02:47.043 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/10/22/2025-10-22T11+02+42.181827164Z_seq0_minr1_maxr501_orgn0.pces
node2 21.859s 2025-10-22 11:02:47.044 262 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/22/2025-10-22T11+02+42.181827164Z_seq0_minr1_maxr501_orgn0.pces
node2 21.860s 2025-10-22 11:02:47.045 263 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 21.861s 2025-10-22 11:02:47.046 264 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 21.868s 2025-10-22 11:02:47.053 265 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 26.072s 2025-10-22 11:02:51.257 290 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 26.543s 2025-10-22 11:02:51.728 290 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 26.629s 2025-10-22 11:02:51.814 290 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 27.690s 2025-10-22 11:02:52.875 291 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 27.795s 2025-10-22 11:02:52.980 294 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 28.220s 2025-10-22 11:02:53.405 295 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 28.300s 2025-10-22 11:02:53.485 303 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 29.320s 2025-10-22 11:02:54.505 303 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 59.496s 2025-10-22 11:03:24.681 496 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 59.611s 2025-10-22 11:03:24.796 496 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 1.006m 2025-10-22 11:03:25.557 508 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 1.016m 2025-10-22 11:03:26.120 508 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 1m 22.834s 2025-10-22 11:03:48.019 633 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node2 1m 22.885s 2025-10-22 11:03:48.070 634 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node2 1m 22.888s 2025-10-22 11:03:48.073 635 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: node2 submits a transaction SAVE_EXPECTED_MAP
node3 1m 24.319s 2025-10-22 11:03:49.504 645 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node3 1m 24.322s 2025-10-22 11:03:49.507 646 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node3 1m 24.323s 2025-10-22 11:03:49.508 647 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: node3 submits a transaction SAVE_EXPECTED_MAP
node0 1m 25.020s 2025-10-22 11:03:50.205 645 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node3 1m 25.160s 2025-10-22 11:03:50.345 656 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node1 1m 25.226s 2025-10-22 11:03:50.411 653 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node2 1m 25.235s 2025-10-22 11:03:50.420 656 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node0 1m 25.344s 2025-10-22 11:03:50.529 654 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node0 1m 25.394s 2025-10-22 11:03:50.579 655 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node0 1m 25.395s 2025-10-22 11:03:50.580 656 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: node0 submits a transaction SAVE_EXPECTED_MAP
node1 1m 25.968s 2025-10-22 11:03:51.153 654 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node1 1m 25.969s 2025-10-22 11:03:51.154 655 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node1 1m 25.970s 2025-10-22 11:03:51.155 656 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: node1 submits a transaction SAVE_EXPECTED_MAP
node0 1m 26.430s 2025-10-22 11:03:51.615 657 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node3 1m 26.571s 2025-10-22 11:03:51.756 657 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node2 1m 26.647s 2025-10-22 11:03:51.832 657 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node1 1m 26.649s 2025-10-22 11:03:51.834 657 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node1 1m 27.779s 2025-10-22 11:03:52.964 670 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1761131030992_992685000.json.gz
node0 1m 27.821s 2025-10-22 11:03:53.006 670 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1761131030992_992685000.json.gz
node2 1m 27.918s 2025-10-22 11:03:53.103 670 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1761131030992_992685000.json.gz
node3 1m 27.982s 2025-10-22 11:03:53.167 670 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1761131030992_992685000.json.gz
node1 1m 28.082s 2025-10-22 11:03:53.267 671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node0 1m 28.107s 2025-10-22 11:03:53.292 671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node2 1m 28.233s 2025-10-22 11:03:53.418 671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node3 1m 28.282s 2025-10-22 11:03:53.467 671 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node3 1m 28.548s 2025-10-22 11:03:53.733 672 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node0 1m 28.557s 2025-10-22 11:03:53.742 672 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node2 1m 28.634s 2025-10-22 11:03:53.819 672 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node1 1m 28.665s 2025-10-22 11:03:53.850 672 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node0 1m 29.734s 2025-10-22 11:03:54.919 685 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 31.448s 2025-10-22 11:03:56.633 698 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 1m 32.299s 2025-10-22 11:03:57.484 697 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 32.845s 2025-10-22 11:03:58.030 701 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 33.623s 2025-10-22 11:03:58.808 709 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 1m 33.812s 2025-10-22 11:03:58.997 710 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 1m 34.360s 2025-10-22 11:03:59.545 710 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 1m 35.286s 2025-10-22 11:04:00.471 714 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 2m 3.437s 2025-10-22 11:04:28.622 895 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 2m 3.439s 2025-10-22 11:04:28.624 896 INFO DEMO_INFO <<app: appMain 0>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node0 2m 3.440s 2025-10-22 11:04:28.625 897 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 2m 3.442s 2025-10-22 11:04:28.627 898 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 2m 3.442s 2025-10-22 11:04:28.627 899 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node2 2m 5.557s 2025-10-22 11:04:30.742 903 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 2m 5.559s 2025-10-22 11:04:30.744 904 INFO DEMO_INFO <<app: appMain 2>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node2 2m 5.559s 2025-10-22 11:04:30.744 905 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 2m 5.559s 2025-10-22 11:04:30.744 906 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 2m 5.559s 2025-10-22 11:04:30.744 907 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node3 2m 5.635s 2025-10-22 11:04:30.820 907 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 2m 5.637s 2025-10-22 11:04:30.822 908 INFO DEMO_INFO <<app: appMain 3>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node3 2m 5.637s 2025-10-22 11:04:30.822 909 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 2m 5.637s 2025-10-22 11:04:30.822 910 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 2m 5.637s 2025-10-22 11:04:30.822 911 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node1 2m 5.736s 2025-10-22 11:04:30.921 907 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 2m 5.738s 2025-10-22 11:04:30.923 908 INFO DEMO_INFO <<app: appMain 1>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node1 2m 5.738s 2025-10-22 11:04:30.923 909 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 2m 5.739s 2025-10-22 11:04:30.924 910 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 2m 5.739s 2025-10-22 11:04:30.924 911 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node0 2m 6.448s 2025-10-22 11:04:31.633 920 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:29.161474439Z ]
node0 2m 6.449s 2025-10-22 11:04:31.634 921 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:29.161474439Z,type=ENTER_VALIDATION]
node3 2m 6.540s 2025-10-22 11:04:31.725 920 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:29.161474439Z ]
node3 2m 6.541s 2025-10-22 11:04:31.726 921 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:29.161474439Z,type=ENTER_VALIDATION]
node1 2m 6.617s 2025-10-22 11:04:31.802 920 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:29.161474439Z ]
node1 2m 6.618s 2025-10-22 11:04:31.803 921 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:29.161474439Z,type=ENTER_VALIDATION]
node2 2m 6.974s 2025-10-22 11:04:32.159 920 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:29.161474439Z ]
node2 2m 6.975s 2025-10-22 11:04:32.160 921 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:29.161474439Z,type=ENTER_VALIDATION]
node0 2m 7.859s 2025-10-22 11:04:33.044 922 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.055947741Z ]
node0 2m 7.860s 2025-10-22 11:04:33.045 923 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:31.055947741Z,type=ENTER_VALIDATION]
node0 2m 7.860s 2025-10-22 11:04:33.045 924 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.173055023Z ]
node0 2m 7.861s 2025-10-22 11:04:33.046 925 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:31.173055023Z,type=ENTER_VALIDATION]
node0 2m 7.862s 2025-10-22 11:04:33.047 928 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.325434101Z ]
node0 2m 7.862s 2025-10-22 11:04:33.047 929 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:31.325434101Z,type=ENTER_VALIDATION]
node0 2m 7.863s 2025-10-22 11:04:33.048 931 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node0 2m 7.864s 2025-10-22 11:04:33.049 933 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node0 2m 7.883s 2025-10-22 11:04:33.068 934 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1761131071325_325434101.json.gz
node3 2m 7.951s 2025-10-22 11:04:33.136 922 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.055947741Z ]
node3 2m 7.952s 2025-10-22 11:04:33.137 923 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:31.055947741Z,type=ENTER_VALIDATION]
node3 2m 7.953s 2025-10-22 11:04:33.138 924 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.173055023Z ]
node3 2m 7.953s 2025-10-22 11:04:33.138 925 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:31.173055023Z,type=ENTER_VALIDATION]
node3 2m 7.954s 2025-10-22 11:04:33.139 928 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.325434101Z ]
node3 2m 7.954s 2025-10-22 11:04:33.139 929 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:31.325434101Z,type=ENTER_VALIDATION]
node3 2m 7.955s 2025-10-22 11:04:33.140 931 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node3 2m 7.957s 2025-10-22 11:04:33.142 933 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node3 2m 7.980s 2025-10-22 11:04:33.165 934 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1761131071325_325434101.json.gz
node1 2m 8.027s 2025-10-22 11:04:33.212 922 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.055947741Z ]
node1 2m 8.028s 2025-10-22 11:04:33.213 923 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:31.055947741Z,type=ENTER_VALIDATION]
node1 2m 8.029s 2025-10-22 11:04:33.214 924 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.173055023Z ]
node1 2m 8.029s 2025-10-22 11:04:33.214 925 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:31.173055023Z,type=ENTER_VALIDATION]
node1 2m 8.031s 2025-10-22 11:04:33.216 928 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.325434101Z ]
node1 2m 8.031s 2025-10-22 11:04:33.216 929 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:31.325434101Z,type=ENTER_VALIDATION]
node1 2m 8.032s 2025-10-22 11:04:33.217 931 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node1 2m 8.034s 2025-10-22 11:04:33.219 933 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node1 2m 8.069s 2025-10-22 11:04:33.254 934 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1761131071325_325434101.json.gz
node0 2m 8.179s 2025-10-22 11:04:33.364 935 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node0 2m 8.179s 2025-10-22 11:04:33.364 936 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:31.325434101Z ]
node3 2m 8.286s 2025-10-22 11:04:33.471 935 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node3 2m 8.286s 2025-10-22 11:04:33.471 936 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:31.325434101Z ]
node2 2m 8.383s 2025-10-22 11:04:33.568 922 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.055947741Z ]
node2 2m 8.383s 2025-10-22 11:04:33.568 923 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:31.055947741Z,type=ENTER_VALIDATION]
node2 2m 8.384s 2025-10-22 11:04:33.569 924 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.173055023Z ]
node2 2m 8.384s 2025-10-22 11:04:33.569 925 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:31.173055023Z,type=ENTER_VALIDATION]
node2 2m 8.386s 2025-10-22 11:04:33.571 928 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-22T11:04:31.325434101Z ]
node2 2m 8.386s 2025-10-22 11:04:33.571 929 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:31.325434101Z,type=ENTER_VALIDATION]
node2 2m 8.387s 2025-10-22 11:04:33.572 931 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node2 2m 8.388s 2025-10-22 11:04:33.573 933 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node1 2m 8.404s 2025-10-22 11:04:33.589 935 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node1 2m 8.405s 2025-10-22 11:04:33.590 936 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:31.325434101Z ]
node2 2m 8.415s 2025-10-22 11:04:33.600 934 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1761131071325_325434101.json.gz
node2 2m 8.729s 2025-10-22 11:04:33.914 943 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1761131071325_325434101.json, consensusTime = 2025-10-22T11:04:31.325434101Z ]
node2 2m 8.729s 2025-10-22 11:04:33.914 944 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:31.325434101Z ]
node1 2m 10.565s 2025-10-22 11:04:35.750 957 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.762006387Z ]
node1 2m 10.565s 2025-10-22 11:04:35.750 958 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:33.762006387Z,type=EXIT_VALIDATION]
node1 2m 10.566s 2025-10-22 11:04:35.751 959 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992466596Z ]
node1 2m 10.566s 2025-10-22 11:04:35.751 960 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:33.992466596Z,type=EXIT_VALIDATION]
node1 2m 10.566s 2025-10-22 11:04:35.751 961 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992468Z ]
node1 2m 10.567s 2025-10-22 11:04:35.752 962 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:33.992468Z,type=EXIT_VALIDATION]
node1 2m 10.567s 2025-10-22 11:04:35.752 963 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:34.345814114Z ]
node1 2m 10.567s 2025-10-22 11:04:35.752 964 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:34.345814114Z,type=EXIT_VALIDATION]
node1 2m 10.567s 2025-10-22 11:04:35.752 965 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node1 2m 10.568s 2025-10-22 11:04:35.753 966 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node1 2m 10.568s 2025-10-22 11:04:35.753 967 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node1 2m 10.571s 2025-10-22 11:04:35.756 968 INFO DEMO_INFO <<PTT: exit-validator 1>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-22T11:04:34.345814114Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 2m 10.588s 2025-10-22 11:04:35.773 957 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.762006387Z ]
node3 2m 10.588s 2025-10-22 11:04:35.773 958 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:33.762006387Z,type=EXIT_VALIDATION]
node3 2m 10.589s 2025-10-22 11:04:35.774 959 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992466596Z ]
node3 2m 10.589s 2025-10-22 11:04:35.774 960 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:33.992466596Z,type=EXIT_VALIDATION]
node3 2m 10.589s 2025-10-22 11:04:35.774 961 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992468Z ]
node3 2m 10.590s 2025-10-22 11:04:35.775 962 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:33.992468Z,type=EXIT_VALIDATION]
node3 2m 10.590s 2025-10-22 11:04:35.775 963 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:34.345814114Z ]
node3 2m 10.590s 2025-10-22 11:04:35.775 964 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:34.345814114Z,type=EXIT_VALIDATION]
node3 2m 10.590s 2025-10-22 11:04:35.775 965 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node3 2m 10.591s 2025-10-22 11:04:35.776 966 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node3 2m 10.592s 2025-10-22 11:04:35.777 967 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node3 2m 10.594s 2025-10-22 11:04:35.779 968 INFO DEMO_INFO <<PTT: exit-validator 3>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-22T11:04:34.345814114Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node2 2m 10.653s 2025-10-22 11:04:35.838 957 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.762006387Z ]
node2 2m 10.654s 2025-10-22 11:04:35.839 958 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:33.762006387Z,type=EXIT_VALIDATION]
node2 2m 10.654s 2025-10-22 11:04:35.839 959 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992466596Z ]
node2 2m 10.654s 2025-10-22 11:04:35.839 960 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:33.992466596Z,type=EXIT_VALIDATION]
node2 2m 10.655s 2025-10-22 11:04:35.840 961 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992468Z ]
node2 2m 10.655s 2025-10-22 11:04:35.840 962 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:33.992468Z,type=EXIT_VALIDATION]
node2 2m 10.655s 2025-10-22 11:04:35.840 963 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:34.345814114Z ]
node2 2m 10.655s 2025-10-22 11:04:35.840 964 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:34.345814114Z,type=EXIT_VALIDATION]
node2 2m 10.655s 2025-10-22 11:04:35.840 965 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node2 2m 10.656s 2025-10-22 11:04:35.841 966 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node2 2m 10.657s 2025-10-22 11:04:35.842 967 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node2 2m 10.659s 2025-10-22 11:04:35.844 968 INFO DEMO_INFO <<PTT: exit-validator 2>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-22T11:04:34.345814114Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 2m 10.665s 2025-10-22 11:04:35.850 957 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.762006387Z ]
node0 2m 10.665s 2025-10-22 11:04:35.850 958 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-22T11:04:33.762006387Z,type=EXIT_VALIDATION]
node0 2m 10.666s 2025-10-22 11:04:35.851 959 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992466596Z ]
node0 2m 10.666s 2025-10-22 11:04:35.851 960 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-22T11:04:33.992466596Z,type=EXIT_VALIDATION]
node0 2m 10.666s 2025-10-22 11:04:35.851 961 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:33.992468Z ]
node0 2m 10.666s 2025-10-22 11:04:35.851 962 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-22T11:04:33.992468Z,type=EXIT_VALIDATION]
node0 2m 10.667s 2025-10-22 11:04:35.852 963 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-22T11:04:34.345814114Z ]
node0 2m 10.667s 2025-10-22 11:04:35.852 964 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-22T11:04:34.345814114Z,type=EXIT_VALIDATION]
node0 2m 10.667s 2025-10-22 11:04:35.852 965 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node0 2m 10.668s 2025-10-22 11:04:35.853 966 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node0 2m 10.669s 2025-10-22 11:04:35.854 967 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 2m 10.669s 2025-10-22 11:04:35.854 968 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 2m 10.669s 2025-10-22 11:04:35.854 969 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-22T11:04:34.345814114Z ]
node0 2m 10.671s 2025-10-22 11:04:35.856 970 INFO DEMO_INFO <<PTT: exit-validator 0>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-22T11:04:34.345814114Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node2 2m 12.493s 2025-10-22 11:04:37.678 981 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761131135
node3 2m 12.566s 2025-10-22 11:04:37.751 981 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761131135
node0 2m 12.575s 2025-10-22 11:04:37.760 983 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761131135
node1 2m 12.679s 2025-10-22 11:04:37.864 981 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1761131135
node2 2m 58.338s 2025-10-22 11:05:23.523 1234 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith0 2 to 0>> NetworkUtils: Connection broken: 2 <- 0
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-22T11:05:23.518666583Z 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-22T11:05:23.518666583Z 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 Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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
node2 2m 58.355s 2025-10-22 11:05:23.540 1235 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 2 to 3>> NetworkUtils: Connection broken: 2 -> 3
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-22T11:05:23.540364312Z 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-22T11:05:23.540364312Z 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 Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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 2m 58.407s 2025-10-22 11:05:23.592 1240 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 0 to 2>> NetworkUtils: Connection broken: 0 -> 2
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) 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)
node2 2m 58.432s 2025-10-22 11:05:23.617 1236 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 2 to 1>> NetworkUtils: Connection broken: 2 <- 1
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.heartbeats.HeartbeatPeerProtocol.acknowledgeHeartbeat(HeartbeatPeerProtocol.java:136) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.runProtocol(HeartbeatPeerProtocol.java:157) 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)
node3 2m 58.433s 2025-10-22 11:05:23.618 1238 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 3 to 2>> NetworkUtils: Connection broken: 3 <- 2
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-22T11:05:23.612781039Z 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-22T11:05:23.612781039Z 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 Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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
node1 2m 58.508s 2025-10-22 11:05:23.693 1238 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 1 to 2>> NetworkUtils: Connection broken: 1 -> 2
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) 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)
node3 2m 58.677s 2025-10-22 11:05:23.862 1239 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 3 to 1>> NetworkUtils: Connection broken: 3 <- 1
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) 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)
node3 2m 58.706s 2025-10-22 11:05:23.891 1240 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith0 3 to 0>> NetworkUtils: Connection broken: 3 <- 0
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) 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)
node1 2m 58.747s 2025-10-22 11:05:23.932 1239 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 1 to 3>> NetworkUtils: Connection broken: 1 -> 3
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) 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)
node0 2m 58.776s 2025-10-22 11:05:23.961 1241 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 0 to 3>> NetworkUtils: Connection broken: 0 -> 3
java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) 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.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) 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)
node2 3m 2.538s 2025-10-22 11:05:27.723 1237 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node2 3m 2.538s 2025-10-22 11:05:27.723 1238 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change CHECKING
node0 3m 3.651s 2025-10-22 11:05:28.836 1242 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node0 3m 3.652s 2025-10-22 11:05:28.837 1243 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change CHECKING
node1 3m 3.707s 2025-10-22 11:05:28.892 1240 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node1 3m 3.708s 2025-10-22 11:05:28.893 1241 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node3 3m 3.801s 2025-10-22 11:05:28.986 1241 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node3 3m 3.802s 2025-10-22 11:05:28.987 1242 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change CHECKING
node1 3m 40.572s 2025-10-22 11:06:05.757 1242 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node1 3m 40.574s 2025-10-22 11:06:05.759 1243 INFO STARTUP <<PTT: exit-validator 1>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 1> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1206) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1153) at java.lang.Thread.run(Thread.java:1583)
node1 3m 40.576s 2025-10-22 11:06:05.761 1244 INFO STARTUP <<PTT: exit-validator 1>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node1 3m 40.577s 2025-10-22 11:06:05.762 1245 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node3 3m 40.595s 2025-10-22 11:06:05.780 1243 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node3 3m 40.598s 2025-10-22 11:06:05.783 1244 INFO STARTUP <<PTT: exit-validator 3>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 3> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1206) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1153) at java.lang.Thread.run(Thread.java:1583)
node3 3m 40.600s 2025-10-22 11:06:05.785 1245 INFO STARTUP <<PTT: exit-validator 3>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node3 3m 40.601s 2025-10-22 11:06:05.786 1246 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node2 3m 40.659s 2025-10-22 11:06:05.844 1239 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node2 3m 40.663s 2025-10-22 11:06:05.848 1240 INFO STARTUP <<PTT: exit-validator 2>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 2> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1206) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1153) at java.lang.Thread.run(Thread.java:1583)
node2 3m 40.664s 2025-10-22 11:06:05.849 1241 INFO STARTUP <<PTT: exit-validator 2>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node2 3m 40.666s 2025-10-22 11:06:05.851 1242 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node0 3m 40.672s 2025-10-22 11:06:05.857 1244 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-22T11:04:34.345814114Z ]
node0 3m 40.674s 2025-10-22 11:06:05.859 1245 INFO STARTUP <<PTT: exit-validator 0>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 0> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1206) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1153) at java.lang.Thread.run(Thread.java:1583)
node0 3m 40.675s 2025-10-22 11:06:05.860 1246 INFO STARTUP <<PTT: exit-validator 0>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node0 3m 40.676s 2025-10-22 11:06:05.861 1247 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.