Node ID






Columns











Log Level






Log Marker











Class












































node0 0.000ns 2025-10-09 11:26:33.604 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 91.000ms 2025-10-09 11:26:33.695 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 107.000ms 2025-10-09 11:26:33.711 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 108.000ms 2025-10-09 11:26:33.712 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 248.000ms 2025-10-09 11:26:33.852 5 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 255.000ms 2025-10-09 11:26:33.859 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 282.000ms 2025-10-09 11:26:33.886 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 283.000ms 2025-10-09 11:26:33.887 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 284.000ms 2025-10-09 11:26:33.888 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 284.000ms 2025-10-09 11:26:33.888 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 284.000ms 2025-10-09 11:26:33.888 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 285.000ms 2025-10-09 11:26:33.889 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 285.000ms 2025-10-09 11:26:33.889 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 286.000ms 2025-10-09 11:26:33.890 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 286.000ms 2025-10-09 11:26:33.890 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 287.000ms 2025-10-09 11:26:33.891 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 287.000ms 2025-10-09 11:26:33.891 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 288.000ms 2025-10-09 11:26:33.892 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 288.000ms 2025-10-09 11:26:33.892 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 288.000ms 2025-10-09 11:26:33.892 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 289.000ms 2025-10-09 11:26:33.893 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 674.000ms 2025-10-09 11:26:34.278 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 1.208s 2025-10-09 11:26:34.812 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 1.294s 2025-10-09 11:26:34.898 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 1.309s 2025-10-09 11:26:34.913 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 1.310s 2025-10-09 11:26:34.914 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.
node2 1.424s 2025-10-09 11:26:35.028 5 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 1.431s 2025-10-09 11:26:35.035 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 1.463s 2025-10-09 11:26:35.067 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 1.464s 2025-10-09 11:26:35.068 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 1.464s 2025-10-09 11:26:35.068 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 1.465s 2025-10-09 11:26:35.069 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 1.465s 2025-10-09 11:26:35.069 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 1.466s 2025-10-09 11:26:35.070 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 1.466s 2025-10-09 11:26:35.070 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 1.467s 2025-10-09 11:26:35.071 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 1.468s 2025-10-09 11:26:35.072 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 1.468s 2025-10-09 11:26:35.072 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 1.468s 2025-10-09 11:26:35.072 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 1.469s 2025-10-09 11:26:35.073 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 1.469s 2025-10-09 11:26:35.073 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 1.469s 2025-10-09 11:26:35.073 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 1.470s 2025-10-09 11:26:35.074 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 1.566s 2025-10-09 11:26:35.170 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 891ms
node0 1.573s 2025-10-09 11:26:35.177 26 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.574s 2025-10-09 11:26:35.178 27 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.613s 2025-10-09 11:26:35.217 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 1.671s 2025-10-09 11:26:35.275 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 1.672s 2025-10-09 11:26:35.276 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node2 1.881s 2025-10-09 11:26:35.485 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node1 1.998s 2025-10-09 11:26:35.602 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 2.094s 2025-10-09 11:26:35.698 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 2.111s 2025-10-09 11:26:35.715 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.112s 2025-10-09 11:26:35.716 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.
node1 2.239s 2025-10-09 11:26:35.843 5 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node1 2.246s 2025-10-09 11:26:35.850 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node1 2.278s 2025-10-09 11:26:35.882 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 2.279s 2025-10-09 11:26:35.883 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 2.279s 2025-10-09 11:26:35.883 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 2.280s 2025-10-09 11:26:35.884 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 2.281s 2025-10-09 11:26:35.885 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 2.281s 2025-10-09 11:26:35.885 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 2.281s 2025-10-09 11:26:35.885 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 2.282s 2025-10-09 11:26:35.886 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 2.283s 2025-10-09 11:26:35.887 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 2.283s 2025-10-09 11:26:35.887 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 2.284s 2025-10-09 11:26:35.888 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 2.284s 2025-10-09 11:26:35.888 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 2.284s 2025-10-09 11:26:35.888 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 2.285s 2025-10-09 11:26:35.889 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 2.285s 2025-10-09 11:26:35.889 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 2.720s 2025-10-09 11:26:36.324 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 2.798s 2025-10-09 11:26:36.402 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 917ms
node2 2.804s 2025-10-09 11:26:36.408 26 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.804s 2025-10-09 11:26:36.408 27 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.841s 2025-10-09 11:26:36.445 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node2 2.899s 2025-10-09 11:26:36.503 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 2.900s 2025-10-09 11:26:36.504 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 3.109s 2025-10-09 11:26:36.713 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node3 3.204s 2025-10-09 11:26:36.808 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 3.222s 2025-10-09 11:26:36.826 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 3.223s 2025-10-09 11:26:36.827 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 3.353s 2025-10-09 11:26:36.957 5 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 3.361s 2025-10-09 11:26:36.965 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 3.394s 2025-10-09 11:26:36.998 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 3.396s 2025-10-09 11:26:37.000 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 3.396s 2025-10-09 11:26:37.000 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 3.397s 2025-10-09 11:26:37.001 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 3.398s 2025-10-09 11:26:37.002 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 3.398s 2025-10-09 11:26:37.002 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 3.398s 2025-10-09 11:26:37.002 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 3.399s 2025-10-09 11:26:37.003 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 3.400s 2025-10-09 11:26:37.004 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 3.400s 2025-10-09 11:26:37.004 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 3.400s 2025-10-09 11:26:37.004 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 3.401s 2025-10-09 11:26:37.005 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 3.401s 2025-10-09 11:26:37.005 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 3.402s 2025-10-09 11:26:37.006 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 3.403s 2025-10-09 11:26:37.007 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 3.644s 2025-10-09 11:26:37.248 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 3.716s 2025-10-09 11:26:37.320 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 3.717s 2025-10-09 11:26:37.321 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 3.717s 2025-10-09 11:26:37.321 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 3.717s 2025-10-09 11:26:37.321 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 3.717s 2025-10-09 11:26:37.321 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 3.718s 2025-10-09 11:26:37.322 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 3.718s 2025-10-09 11:26:37.322 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 3.718s 2025-10-09 11:26:37.322 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 3.724s 2025-10-09 11:26:37.328 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1003ms
node1 3.731s 2025-10-09 11:26:37.335 26 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 3.732s 2025-10-09 11:26:37.336 27 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 3.773s 2025-10-09 11:26:37.377 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 3.837s 2025-10-09 11:26:37.441 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 3.839s 2025-10-09 11:26:37.443 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 3.846s 2025-10-09 11:26:37.450 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node0 4.472s 2025-10-09 11:26:38.076 51 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 4.477s 2025-10-09 11:26:38.081 52 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 4.920s 2025-10-09 11:26:38.524 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 4.993s 2025-10-09 11:26:38.597 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 4.994s 2025-10-09 11:26:38.598 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 4.994s 2025-10-09 11:26:38.598 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 4.995s 2025-10-09 11:26:38.599 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 4.995s 2025-10-09 11:26:38.599 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 4.995s 2025-10-09 11:26:38.599 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 4.995s 2025-10-09 11:26:38.599 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 4.996s 2025-10-09 11:26:38.600 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 5.201s 2025-10-09 11:26:38.805 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1355ms
node3 5.212s 2025-10-09 11:26:38.816 26 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 5.212s 2025-10-09 11:26:38.816 27 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 5.260s 2025-10-09 11:26:38.864 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 5.350s 2025-10-09 11:26:38.954 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 5.351s 2025-10-09 11:26:38.955 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 5.597s 2025-10-09 11:26:39.201 53 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26970102] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=126780, randomLong=-3799648877511680203, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=12530, randomLong=-7119080026600609621, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=924250, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms)
node0 5.625s 2025-10-09 11:26:39.229 54 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 5.632s 2025-10-09 11:26:39.236 55 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 5.637s 2025-10-09 11:26:39.241 56 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 5.710s 2025-10-09 11:26:39.314 57 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": "IoZ/Bw==", "port": 30124 }, { "ipAddressV4": "CoAP6Q==", "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": "aMba+A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "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": "IhwGjg==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "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": "IoWOmw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] }
node2 5.760s 2025-10-09 11:26:39.364 51 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 5.765s 2025-10-09 11:26:39.369 52 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 5.801s 2025-10-09 11:26:39.405 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 5.804s 2025-10-09 11:26:39.408 58 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 5.805s 2025-10-09 11:26:39.409 59 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 5.820s 2025-10-09 11:26:39.424 60 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: 51400797602ee2d4aeb7c75d13b727df57b0d734168daae8fa8b72c82cc81fcee9ce8755e050e914fcb124a1c1c5bf08 (root) PlatformTestingToolState / chimney-very-alarm-pitch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 5.878s 2025-10-09 11:26:39.482 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 5.879s 2025-10-09 11:26:39.483 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 5.879s 2025-10-09 11:26:39.483 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 5.880s 2025-10-09 11:26:39.484 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 5.880s 2025-10-09 11:26:39.484 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 5.880s 2025-10-09 11:26:39.484 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 5.881s 2025-10-09 11:26:39.485 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 5.881s 2025-10-09 11:26:39.485 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 6.034s 2025-10-09 11:26:39.638 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 6.038s 2025-10-09 11:26:39.642 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 6.047s 2025-10-09 11:26:39.651 64 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 6.047s 2025-10-09 11:26:39.651 65 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 6.048s 2025-10-09 11:26:39.652 66 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 6.048s 2025-10-09 11:26:39.652 67 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 6.049s 2025-10-09 11:26:39.653 68 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 6.049s 2025-10-09 11:26:39.653 69 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 6.049s 2025-10-09 11:26:39.653 70 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 6.049s 2025-10-09 11:26:39.653 71 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 6.050s 2025-10-09 11:26:39.654 72 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 6.050s 2025-10-09 11:26:39.654 73 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 6.050s 2025-10-09 11:26:39.654 74 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 6.050s 2025-10-09 11:26:39.654 75 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 6.051s 2025-10-09 11:26:39.655 76 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 6.051s 2025-10-09 11:26:39.655 77 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 6.051s 2025-10-09 11:26:39.655 78 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node0 6.069s 2025-10-09 11:26:39.673 79 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 6.069s 2025-10-09 11:26:39.673 80 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 6.069s 2025-10-09 11:26:39.673 81 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 6.070s 2025-10-09 11:26:39.674 82 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 6.070s 2025-10-09 11:26:39.674 83 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 6.070s 2025-10-09 11:26:39.674 84 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node0 6.071s 2025-10-09 11:26:39.675 85 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 6.072s 2025-10-09 11:26:39.676 86 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node0 6.077s 2025-10-09 11:26:39.681 87 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@4c98fb40
node0 6.078s 2025-10-09 11:26:39.682 88 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 2400
node0 6.078s 2025-10-09 11:26:39.682 89 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node0 6.086s 2025-10-09 11:26:39.690 94 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@1289aae7, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@279c2331,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@5e60cde9,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@69a178e3,snapshotInProgress=false]
node0 6.093s 2025-10-09 11:26:39.697 95 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 6.094s 2025-10-09 11:26:39.698 96 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 6.098s 2025-10-09 11:26:39.702 97 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is 8653345395073240543
node0 6.099s 2025-10-09 11:26:39.703 98 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 6.176s 2025-10-09 11:26:39.780 99 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 6.177s 2025-10-09 11:26:39.781 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 6.181s 2025-10-09 11:26:39.785 101 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 6.181s 2025-10-09 11:26:39.785 102 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 6.182s 2025-10-09 11:26:39.786 103 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 6.184s 2025-10-09 11:26:39.788 104 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 6.184s 2025-10-09 11:26:39.788 105 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 6.185s 2025-10-09 11:26:39.789 106 INFO STARTUP <<start-node-0>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. 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.186s 2025-10-09 11:26:39.790 107 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 6.186s 2025-10-09 11:26:39.790 108 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 314.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 6.189s 2025-10-09 11:26:39.793 109 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 6.190s 2025-10-09 11:26:39.794 110 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 6.190s 2025-10-09 11:26:39.794 111 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 6.725s 2025-10-09 11:26:40.329 51 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 6.730s 2025-10-09 11:26:40.334 52 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 6.873s 2025-10-09 11:26:40.477 53 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26300806] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=180580, randomLong=998023653685896898, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=43530, randomLong=8755376846742816134, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1333540, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms)
node2 6.902s 2025-10-09 11:26:40.506 54 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node2 6.910s 2025-10-09 11:26:40.514 55 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 6.915s 2025-10-09 11:26:40.519 56 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 6.995s 2025-10-09 11:26:40.599 57 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": "IoZ/Bw==", "port": 30124 }, { "ipAddressV4": "CoAP6Q==", "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": "aMba+A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "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": "IhwGjg==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "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": "IoWOmw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] }
node2 7.090s 2025-10-09 11:26:40.694 58 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 7.090s 2025-10-09 11:26:40.694 59 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 7.105s 2025-10-09 11:26:40.709 60 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: 51400797602ee2d4aeb7c75d13b727df57b0d734168daae8fa8b72c82cc81fcee9ce8755e050e914fcb124a1c1c5bf08 (root) PlatformTestingToolState / chimney-very-alarm-pitch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 7.298s 2025-10-09 11:26:40.902 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 7.302s 2025-10-09 11:26:40.906 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 7.311s 2025-10-09 11:26:40.915 64 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 7.311s 2025-10-09 11:26:40.915 65 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 7.312s 2025-10-09 11:26:40.916 66 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 7.312s 2025-10-09 11:26:40.916 67 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 7.313s 2025-10-09 11:26:40.917 68 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 7.313s 2025-10-09 11:26:40.917 69 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 7.313s 2025-10-09 11:26:40.917 70 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 7.313s 2025-10-09 11:26:40.917 71 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 7.314s 2025-10-09 11:26:40.918 72 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 7.314s 2025-10-09 11:26:40.918 73 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 7.314s 2025-10-09 11:26:40.918 74 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 7.315s 2025-10-09 11:26:40.919 75 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 7.315s 2025-10-09 11:26:40.919 76 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 7.315s 2025-10-09 11:26:40.919 77 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 7.316s 2025-10-09 11:26:40.920 78 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node2 7.332s 2025-10-09 11:26:40.936 79 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 7.333s 2025-10-09 11:26:40.937 80 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 7.333s 2025-10-09 11:26:40.937 81 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 7.334s 2025-10-09 11:26:40.938 82 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 7.334s 2025-10-09 11:26:40.938 83 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 7.334s 2025-10-09 11:26:40.938 84 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node2 7.335s 2025-10-09 11:26:40.939 85 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 7.336s 2025-10-09 11:26:40.940 86 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node2 7.341s 2025-10-09 11:26:40.945 87 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@4c98fb40
node2 7.342s 2025-10-09 11:26:40.946 88 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 2400
node2 7.342s 2025-10-09 11:26:40.946 89 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node2 7.349s 2025-10-09 11:26:40.953 94 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@1289aae7, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@279c2331,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@5e60cde9,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@69a178e3,snapshotInProgress=false]
node2 7.357s 2025-10-09 11:26:40.961 95 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 7.358s 2025-10-09 11:26:40.962 96 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 7.362s 2025-10-09 11:26:40.966 97 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is -7998180137117176419
node2 7.363s 2025-10-09 11:26:40.967 98 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 7.421s 2025-10-09 11:26:41.025 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 7.441s 2025-10-09 11:26:41.045 99 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node2 7.443s 2025-10-09 11:26:41.047 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 7.446s 2025-10-09 11:26:41.050 101 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 7.447s 2025-10-09 11:26:41.051 102 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 7.448s 2025-10-09 11:26:41.052 103 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 7.450s 2025-10-09 11:26:41.054 104 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node2 7.450s 2025-10-09 11:26:41.054 105 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 7.451s 2025-10-09 11:26:41.055 106 INFO STARTUP <<start-node-2>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node2 7.452s 2025-10-09 11:26:41.056 107 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 7.452s 2025-10-09 11:26:41.056 108 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 296.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 7.456s 2025-10-09 11:26:41.060 109 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 7.456s 2025-10-09 11:26:41.060 110 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 7.457s 2025-10-09 11:26:41.061 111 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node3 7.527s 2025-10-09 11:26:41.131 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 7.528s 2025-10-09 11:26:41.132 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 7.529s 2025-10-09 11:26:41.133 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 7.529s 2025-10-09 11:26:41.133 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 7.530s 2025-10-09 11:26:41.134 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 7.530s 2025-10-09 11:26:41.134 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 7.530s 2025-10-09 11:26:41.134 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 7.530s 2025-10-09 11:26:41.134 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 7.866s 2025-10-09 11:26:41.470 53 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26133376] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=202640, randomLong=-1018924292935183428, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13060, randomLong=-1375108321171419752, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1027810, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms)
node1 7.895s 2025-10-09 11:26:41.499 54 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 7.903s 2025-10-09 11:26:41.507 55 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 7.908s 2025-10-09 11:26:41.512 56 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node1 7.988s 2025-10-09 11:26:41.592 57 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": "IoZ/Bw==", "port": 30124 }, { "ipAddressV4": "CoAP6Q==", "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": "aMba+A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "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": "IhwGjg==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "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": "IoWOmw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] }
node1 8.087s 2025-10-09 11:26:41.691 58 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 8.088s 2025-10-09 11:26:41.692 59 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 8.104s 2025-10-09 11:26:41.708 60 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: 51400797602ee2d4aeb7c75d13b727df57b0d734168daae8fa8b72c82cc81fcee9ce8755e050e914fcb124a1c1c5bf08 (root) PlatformTestingToolState / chimney-very-alarm-pitch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 8.319s 2025-10-09 11:26:41.923 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 8.324s 2025-10-09 11:26:41.928 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 8.333s 2025-10-09 11:26:41.937 64 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 8.334s 2025-10-09 11:26:41.938 65 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 8.334s 2025-10-09 11:26:41.938 66 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 8.335s 2025-10-09 11:26:41.939 67 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 8.335s 2025-10-09 11:26:41.939 68 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 8.335s 2025-10-09 11:26:41.939 69 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 8.336s 2025-10-09 11:26:41.940 70 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 8.336s 2025-10-09 11:26:41.940 71 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 8.336s 2025-10-09 11:26:41.940 72 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 8.336s 2025-10-09 11:26:41.940 73 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 8.337s 2025-10-09 11:26:41.941 74 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 8.337s 2025-10-09 11:26:41.941 75 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 8.338s 2025-10-09 11:26:41.942 76 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 8.338s 2025-10-09 11:26:41.942 77 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 8.338s 2025-10-09 11:26:41.942 78 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node1 8.355s 2025-10-09 11:26:41.959 79 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 8.356s 2025-10-09 11:26:41.960 80 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 8.356s 2025-10-09 11:26:41.960 81 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 8.357s 2025-10-09 11:26:41.961 82 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 8.357s 2025-10-09 11:26:41.961 83 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 8.357s 2025-10-09 11:26:41.961 84 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node1 8.358s 2025-10-09 11:26:41.962 85 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 8.359s 2025-10-09 11:26:41.963 86 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node1 8.364s 2025-10-09 11:26:41.968 87 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@26eff5e9
node1 8.365s 2025-10-09 11:26:41.969 88 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 2400
node1 8.365s 2025-10-09 11:26:41.969 89 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node1 8.373s 2025-10-09 11:26:41.977 94 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@72f254b0, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6daf64c9,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@44e5f5c8,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@7acf3ef1,snapshotInProgress=false]
node1 8.381s 2025-10-09 11:26:41.985 95 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 8.381s 2025-10-09 11:26:41.985 96 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 8.386s 2025-10-09 11:26:41.990 97 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is 5589754345539272616
node1 8.386s 2025-10-09 11:26:41.990 98 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 8.429s 2025-10-09 11:26:42.033 51 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node3 8.437s 2025-10-09 11:26:42.041 52 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 8.469s 2025-10-09 11:26:42.073 99 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 8.471s 2025-10-09 11:26:42.075 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 8.475s 2025-10-09 11:26:42.079 101 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 8.476s 2025-10-09 11:26:42.080 102 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 8.477s 2025-10-09 11:26:42.081 103 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 8.479s 2025-10-09 11:26:42.083 104 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 8.479s 2025-10-09 11:26:42.083 105 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 8.480s 2025-10-09 11:26:42.084 106 INFO STARTUP <<start-node-1>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node1 8.481s 2025-10-09 11:26:42.085 107 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 8.482s 2025-10-09 11:26:42.086 108 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 324.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 8.486s 2025-10-09 11:26:42.090 109 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 8.486s 2025-10-09 11:26:42.090 110 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 8.487s 2025-10-09 11:26:42.091 111 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 9.055s 2025-10-09 11:26:42.659 112 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.057s 2025-10-09 11:26:42.661 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 9.605s 2025-10-09 11:26:43.209 53 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26230167] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=319831, randomLong=3800955487973852777, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=16769, randomLong=-6629603715116435941, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1167011, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms)
node3 9.641s 2025-10-09 11:26:43.245 54 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 9.650s 2025-10-09 11:26:43.254 55 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 9.656s 2025-10-09 11:26:43.260 56 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 9.751s 2025-10-09 11:26:43.355 57 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": "IoZ/Bw==", "port": 30124 }, { "ipAddressV4": "CoAP6Q==", "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": "aMba+A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "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": "IhwGjg==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "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": "IoWOmw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] }
node3 9.866s 2025-10-09 11:26:43.470 58 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 9.867s 2025-10-09 11:26:43.471 59 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 9.885s 2025-10-09 11:26:43.489 60 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: 51400797602ee2d4aeb7c75d13b727df57b0d734168daae8fa8b72c82cc81fcee9ce8755e050e914fcb124a1c1c5bf08 (root) PlatformTestingToolState / chimney-very-alarm-pitch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 10.084s 2025-10-09 11:26:43.688 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 10.089s 2025-10-09 11:26:43.693 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 10.100s 2025-10-09 11:26:43.704 64 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 10.101s 2025-10-09 11:26:43.705 65 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 10.101s 2025-10-09 11:26:43.705 66 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 10.102s 2025-10-09 11:26:43.706 67 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 10.102s 2025-10-09 11:26:43.706 68 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 10.103s 2025-10-09 11:26:43.707 69 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 10.103s 2025-10-09 11:26:43.707 70 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 10.103s 2025-10-09 11:26:43.707 71 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 10.104s 2025-10-09 11:26:43.708 72 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 10.104s 2025-10-09 11:26:43.708 73 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 10.104s 2025-10-09 11:26:43.708 74 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 10.105s 2025-10-09 11:26:43.709 75 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 10.105s 2025-10-09 11:26:43.709 76 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 10.105s 2025-10-09 11:26:43.709 77 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 10.105s 2025-10-09 11:26:43.709 78 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node3 10.124s 2025-10-09 11:26:43.728 79 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 10.125s 2025-10-09 11:26:43.729 80 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 10.125s 2025-10-09 11:26:43.729 81 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 10.125s 2025-10-09 11:26:43.729 82 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 10.126s 2025-10-09 11:26:43.730 83 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 10.126s 2025-10-09 11:26:43.730 84 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node3 10.127s 2025-10-09 11:26:43.731 85 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 10.128s 2025-10-09 11:26:43.732 86 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node3 10.135s 2025-10-09 11:26:43.739 87 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@17dbc940
node3 10.137s 2025-10-09 11:26:43.741 88 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 2400
node3 10.137s 2025-10-09 11:26:43.741 89 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node3 10.146s 2025-10-09 11:26:43.750 94 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@42d4deab, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1e9e5c8d,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@4391beab,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@3b64b14c,snapshotInProgress=false]
node3 10.154s 2025-10-09 11:26:43.758 95 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 10.154s 2025-10-09 11:26:43.758 96 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 10.160s 2025-10-09 11:26:43.764 97 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is -310970343386984368
node3 10.160s 2025-10-09 11:26:43.764 98 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 10.243s 2025-10-09 11:26:43.847 99 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 10.244s 2025-10-09 11:26:43.848 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 10.248s 2025-10-09 11:26:43.852 101 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 10.250s 2025-10-09 11:26:43.854 102 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 10.251s 2025-10-09 11:26:43.855 103 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 10.253s 2025-10-09 11:26:43.857 104 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 10.254s 2025-10-09 11:26:43.858 105 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 10.255s 2025-10-09 11:26:43.859 106 INFO STARTUP <<start-node-3>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. 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 10.256s 2025-10-09 11:26:43.860 107 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 10.256s 2025-10-09 11:26:43.860 108 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 314.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 10.260s 2025-10-09 11:26:43.864 109 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 10.261s 2025-10-09 11:26:43.865 110 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 10.261s 2025-10-09 11:26:43.865 111 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 10.319s 2025-10-09 11:26:43.923 112 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 10.321s 2025-10-09 11:26:43.925 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 11.341s 2025-10-09 11:26:44.945 112 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 11.343s 2025-10-09 11:26:44.947 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 13.110s 2025-10-09 11:26:46.714 112 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 13.114s 2025-10-09 11:26:46.718 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 16.283s 2025-10-09 11:26:49.887 114 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 16.284s 2025-10-09 11:26:49.888 115 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node2 17.550s 2025-10-09 11:26:51.154 114 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 17.551s 2025-10-09 11:26:51.155 115 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change CHECKING
node1 18.579s 2025-10-09 11:26:52.183 114 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 18.580s 2025-10-09 11:26:52.184 115 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node1 20.165s 2025-10-09 11:26:53.769 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 20.168s 2025-10-09 11:26:53.772 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 20.168s 2025-10-09 11:26:53.772 117 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 3.9 s in CHECKING. Now in ACTIVE
node0 20.168s 2025-10-09 11:26:53.772 118 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 20.238s 2025-10-09 11:26:53.842 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 20.246s 2025-10-09 11:26:53.850 119 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x7A9931B36A985B6B91131FA8BC0B7AB7E7FCA9E3FF04EBF0A69B292933F115B0', privateKey ='0x7A9931B36A985B6B91131FA8BC0B7AB7E7FCA9E3FF04EBF0A69B292933F115B0', signature = '0x874936C16B13709F525BE49BEB791273553A5ED2C07917254EE234334550CDAF6D9B2F8183CE53EDBADFA8C4ADDEC69D9F081C4BC70A12B70603C11D7B6F5A04',message = '0x12660A0A4080BC9493A4ABBF921F325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' }
node3 20.323s 2025-10-09 11:26:53.927 114 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 20.353s 2025-10-09 11:26:53.957 115 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 20.354s 2025-10-09 11:26:53.958 116 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node1 20.936s 2025-10-09 11:26:54.540 117 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.4 s in CHECKING. Now in ACTIVE
node1 20.937s 2025-10-09 11:26:54.541 118 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 20.938s 2025-10-09 11:26:54.542 117 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.4 s in CHECKING. Now in ACTIVE
node2 20.938s 2025-10-09 11:26:54.542 118 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 20.971s 2025-10-09 11:26:54.575 119 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x978D5999B0E7DC38572EBEBCD4FEC599719310BAFF9E931A96472F3D08316188', privateKey ='0x978D5999B0E7DC38572EBEBCD4FEC599719310BAFF9E931A96472F3D08316188', signature = '0x99CF462EAD8382D0D04A962B9CC859731EF554E7E775B2958F026B375604B465FCA4C0099127D6C773F49CC72B59E25B96AA2B739A3DCB0D95626A5CF81BFE04',message = '0x12660A1A0801100118E01220E01228E01230E01240859F9D81D8E3BCA0213244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038014001' }
node2 20.988s 2025-10-09 11:26:54.592 119 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x61D84FB2187BDEAD706611CC9D615B0CCBFD955E47A099B8D31D9A3F3E84E0A2', privateKey ='0x61D84FB2187BDEAD706611CC9D615B0CCBFD955E47A099B8D31D9A3F3E84E0A2', signature = '0x84D424947E351C03BFD01140E1A7450C35F204B68A8F78BC9F2DF9608F63B1FDAB70815C5FD7CBA17C2E761B978B69D14FE91716692F816EA1C90A77ABF9A704',message = '0x1A6B0A1A08021002180120A18D0628914E30914E4083F99996BBCEA8A9532A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' }
node0 21.573s 2025-10-09 11:26:55.177 122 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node2 21.641s 2025-10-09 11:26:55.245 122 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node1 21.668s 2025-10-09 11:26:55.272 122 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node3 21.854s 2025-10-09 11:26:55.458 119 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node1 22.120s 2025-10-09 11:26:55.724 137 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3
node1 22.122s 2025-10-09 11:26:55.726 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 22.204s 2025-10-09 11:26:55.808 137 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3
node0 22.205s 2025-10-09 11:26:55.809 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 22.278s 2025-10-09 11:26:55.882 134 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3
node3 22.280s 2025-10-09 11:26:55.884 135 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 22.397s 2025-10-09 11:26:56.001 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 22.401s 2025-10-09 11:26:56.005 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-09T11:26:53.822859Z Next consensus number: 17 Legacy running event hash: 11e54f1f1268396d145331bf8dfc079faf978b69fd7708a016d98ef3412c68e040516cc3cd5ff2f17aeaae6a43141266 Legacy running event mnemonic: device-token-escape-color Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 667c3d5269b211c5649e372d5ab38ff3ab8f6d34d84c7c478b28b2bcc2abcfec251f07e8ba1efdd0cd3aca6a9e58845c (root) PlatformTestingToolState / sort-prevent-curve-december 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 also-rural-monitor-maze 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 22.435s 2025-10-09 11:26:56.039 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/10/09/2025-10-09T11+26+50.154935648Z_seq0_minr1_maxr501_orgn0.pces
node1 22.435s 2025-10-09 11:26:56.039 198 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/09/2025-10-09T11+26+50.154935648Z_seq0_minr1_maxr501_orgn0.pces
node1 22.435s 2025-10-09 11:26:56.039 199 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 22.437s 2025-10-09 11:26:56.041 200 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 22.442s 2025-10-09 11:26:56.046 201 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 22.459s 2025-10-09 11:26:56.063 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 22.463s 2025-10-09 11:26:56.067 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-09T11:26:53.822859Z Next consensus number: 17 Legacy running event hash: 11e54f1f1268396d145331bf8dfc079faf978b69fd7708a016d98ef3412c68e040516cc3cd5ff2f17aeaae6a43141266 Legacy running event mnemonic: device-token-escape-color Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 667c3d5269b211c5649e372d5ab38ff3ab8f6d34d84c7c478b28b2bcc2abcfec251f07e8ba1efdd0cd3aca6a9e58845c (root) PlatformTestingToolState / sort-prevent-curve-december 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 also-rural-monitor-maze 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 22.477s 2025-10-09 11:26:56.081 137 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3
node2 22.480s 2025-10-09 11:26:56.084 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 22.492s 2025-10-09 11:26:56.096 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/10/09/2025-10-09T11+26+49.928556051Z_seq0_minr1_maxr501_orgn0.pces
node0 22.493s 2025-10-09 11:26:56.097 198 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/09/2025-10-09T11+26+49.928556051Z_seq0_minr1_maxr501_orgn0.pces
node0 22.493s 2025-10-09 11:26:56.097 199 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 22.494s 2025-10-09 11:26:56.098 200 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 22.498s 2025-10-09 11:26:56.102 201 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 22.567s 2025-10-09 11:26:56.171 177 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 2.2 s in CHECKING. Now in ACTIVE
node3 22.567s 2025-10-09 11:26:56.171 178 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 22.582s 2025-10-09 11:26:56.186 194 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 22.585s 2025-10-09 11:26:56.189 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-09T11:26:53.822859Z Next consensus number: 17 Legacy running event hash: 11e54f1f1268396d145331bf8dfc079faf978b69fd7708a016d98ef3412c68e040516cc3cd5ff2f17aeaae6a43141266 Legacy running event mnemonic: device-token-escape-color Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 667c3d5269b211c5649e372d5ab38ff3ab8f6d34d84c7c478b28b2bcc2abcfec251f07e8ba1efdd0cd3aca6a9e58845c (root) PlatformTestingToolState / sort-prevent-curve-december 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 also-rural-monitor-maze 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 22.589s 2025-10-09 11:26:56.193 196 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x246855EC9B400F72C7181C3E4CC0CDFBC17E85456BC192EB8C28EEF293759274', privateKey ='0x246855EC9B400F72C7181C3E4CC0CDFBC17E85456BC192EB8C28EEF293759274', signature = '0x541D2E91128846B1CF125CC58BB4558D11BDC1F9BF0A0C5B508D87907BF832A2D3EAE9343497D2DBBA9B77DF203585B4C4E031E0B8F9577435ED7C1D08F2030D',message = '0x12660A1A0803100318A03820A03828A03830A03840E7D3C388D8E388C1123244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' }
node3 22.621s 2025-10-09 11:26:56.225 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/10/09/2025-10-09T11+26+50.371254301Z_seq0_minr1_maxr501_orgn0.pces
node3 22.622s 2025-10-09 11:26:56.226 198 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/09/2025-10-09T11+26+50.371254301Z_seq0_minr1_maxr501_orgn0.pces
node3 22.622s 2025-10-09 11:26:56.226 199 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 22.624s 2025-10-09 11:26:56.228 200 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 22.629s 2025-10-09 11:26:56.233 201 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 22.762s 2025-10-09 11:26:56.366 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node2 22.765s 2025-10-09 11:26:56.369 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-10-09T11:26:53.822859Z Next consensus number: 17 Legacy running event hash: 11e54f1f1268396d145331bf8dfc079faf978b69fd7708a016d98ef3412c68e040516cc3cd5ff2f17aeaae6a43141266 Legacy running event mnemonic: device-token-escape-color Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 667c3d5269b211c5649e372d5ab38ff3ab8f6d34d84c7c478b28b2bcc2abcfec251f07e8ba1efdd0cd3aca6a9e58845c (root) PlatformTestingToolState / sort-prevent-curve-december 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 also-rural-monitor-maze 1 VirtualMap RosterService.ROSTERS /1 question-latin-cargo-indicate 2 SingletonNode RosterService.ROSTER_STATE /2 subway-message-bomb-destroy 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 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 22.798s 2025-10-09 11:26:56.402 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/10/09/2025-10-09T11+26+50.160309852Z_seq0_minr1_maxr501_orgn0.pces
node2 22.799s 2025-10-09 11:26:56.403 198 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/09/2025-10-09T11+26+50.160309852Z_seq0_minr1_maxr501_orgn0.pces
node2 22.799s 2025-10-09 11:26:56.403 199 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 22.800s 2025-10-09 11:26:56.404 200 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 22.805s 2025-10-09 11:26:56.409 201 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.961s 2025-10-09 11:27:00.565 242 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 27.236s 2025-10-09 11:27:00.840 242 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 27.293s 2025-10-09 11:27:00.897 242 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 28.613s 2025-10-09 11:27:02.217 262 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 28.632s 2025-10-09 11:27:02.236 263 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 28.807s 2025-10-09 11:27:02.411 263 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 28.866s 2025-10-09 11:27:02.470 263 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 30.087s 2025-10-09 11:27:03.691 267 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 1.001m 2025-10-09 11:27:33.671 604 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 1.017m 2025-10-09 11:27:34.600 604 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 1m 1.791s 2025-10-09 11:27:35.395 608 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 1m 2.744s 2025-10-09 11:27:36.348 624 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 1m 23.212s 2025-10-09 11:27:56.816 825 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node0 1m 23.263s 2025-10-09 11:27:56.867 826 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node0 1m 23.266s 2025-10-09 11:27:56.870 827 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: node0 submits a transaction SAVE_EXPECTED_MAP
node1 1m 23.951s 2025-10-09 11:27:57.555 829 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node1 1m 23.952s 2025-10-09 11:27:57.556 830 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node1 1m 23.953s 2025-10-09 11:27:57.557 831 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: node1 submits a transaction SAVE_EXPECTED_MAP
node1 1m 25.368s 2025-10-09 11:27:58.972 852 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1760009277186_186469011.json.gz
node0 1m 25.471s 2025-10-09 11:27:59.075 868 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1760009277186_186469011.json.gz
node3 1m 25.486s 2025-10-09 11:27:59.090 865 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1760009277186_186469011.json.gz
node1 1m 25.645s 2025-10-09 11:27:59.249 869 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node2 1m 25.673s 2025-10-09 11:27:59.277 865 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1760009277186_186469011.json.gz
node0 1m 25.747s 2025-10-09 11:27:59.351 869 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node3 1m 25.788s 2025-10-09 11:27:59.392 866 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node2 1m 25.955s 2025-10-09 11:27:59.559 866 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node1 1m 25.975s 2025-10-09 11:27:59.579 870 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node0 1m 26.040s 2025-10-09 11:27:59.644 870 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node2 1m 26.059s 2025-10-09 11:27:59.663 867 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node2 1m 26.060s 2025-10-09 11:27:59.664 868 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node2 1m 26.061s 2025-10-09 11:27:59.665 869 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: node2 submits a transaction SAVE_EXPECTED_MAP
node2 1m 26.130s 2025-10-09 11:27:59.734 870 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node3 1m 26.343s 2025-10-09 11:27:59.947 867 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node3 1m 26.368s 2025-10-09 11:27:59.972 868 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node3 1m 26.369s 2025-10-09 11:27:59.973 869 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node3 1m 26.369s 2025-10-09 11:27:59.973 870 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: node3 submits a transaction SAVE_EXPECTED_MAP
node1 1m 28.119s 2025-10-09 11:28:01.723 891 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node1 1m 28.122s 2025-10-09 11:28:01.726 892 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node0 1m 28.182s 2025-10-09 11:28:01.786 891 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node0 1m 28.184s 2025-10-09 11:28:01.788 892 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node3 1m 28.315s 2025-10-09 11:28:01.919 891 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node3 1m 28.317s 2025-10-09 11:28:01.921 892 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node2 1m 28.491s 2025-10-09 11:28:02.095 891 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node2 1m 28.493s 2025-10-09 11:28:02.097 892 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node2 1m 31.764s 2025-10-09 11:28:05.368 933 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 33.295s 2025-10-09 11:28:06.899 937 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 33.379s 2025-10-09 11:28:06.983 938 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 1m 33.733s 2025-10-09 11:28:07.337 937 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 34.858s 2025-10-09 11:28:08.462 954 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 1m 34.957s 2025-10-09 11:28:08.561 953 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 35.345s 2025-10-09 11:28:08.949 958 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 1m 36.421s 2025-10-09 11:28:10.025 974 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 2m 5.595s 2025-10-09 11:28:39.199 1255 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 2m 5.597s 2025-10-09 11:28:39.201 1256 INFO DEMO_INFO <<app: appMain 2>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node2 2m 5.597s 2025-10-09 11:28:39.201 1257 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 2m 5.601s 2025-10-09 11:28:39.205 1258 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 2m 5.604s 2025-10-09 11:28:39.208 1259 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node0 2m 6.483s 2025-10-09 11:28:40.087 1255 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 2m 6.484s 2025-10-09 11:28:40.088 1256 INFO DEMO_INFO <<app: appMain 0>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node0 2m 6.484s 2025-10-09 11:28:40.088 1257 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 2m 6.485s 2025-10-09 11:28:40.089 1258 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 2m 6.487s 2025-10-09 11:28:40.091 1259 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node1 2m 6.771s 2025-10-09 11:28:40.375 1259 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 2m 6.772s 2025-10-09 11:28:40.376 1260 INFO DEMO_INFO <<app: appMain 1>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node1 2m 6.773s 2025-10-09 11:28:40.377 1261 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 2m 6.773s 2025-10-09 11:28:40.377 1262 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 2m 6.775s 2025-10-09 11:28:40.379 1263 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node3 2m 7.716s 2025-10-09 11:28:41.320 1275 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 2m 7.717s 2025-10-09 11:28:41.321 1276 INFO DEMO_INFO <<app: appMain 3>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node3 2m 7.718s 2025-10-09 11:28:41.322 1277 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 2m 7.718s 2025-10-09 11:28:41.322 1278 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 2m 7.722s 2025-10-09 11:28:41.326 1279 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node2 2m 7.877s 2025-10-09 11:28:41.481 1280 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:39.572838Z ]
node2 2m 7.877s 2025-10-09 11:28:41.481 1281 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:39.572838Z,type=ENTER_VALIDATION]
node0 2m 8.015s 2025-10-09 11:28:41.619 1280 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:39.572838Z ]
node0 2m 8.016s 2025-10-09 11:28:41.620 1281 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:39.572838Z,type=ENTER_VALIDATION]
node1 2m 8.096s 2025-10-09 11:28:41.700 1280 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:39.572838Z ]
node1 2m 8.097s 2025-10-09 11:28:41.701 1281 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:39.572838Z,type=ENTER_VALIDATION]
node3 2m 8.173s 2025-10-09 11:28:41.777 1280 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:39.572838Z ]
node3 2m 8.174s 2025-10-09 11:28:41.778 1281 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:39.572838Z,type=ENTER_VALIDATION]
node3 2m 8.732s 2025-10-09 11:28:42.336 1282 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.722009082Z ]
node3 2m 8.733s 2025-10-09 11:28:42.337 1283 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:40.722009082Z,type=ENTER_VALIDATION]
node3 2m 8.733s 2025-10-09 11:28:42.337 1284 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.826780617Z ]
node3 2m 8.734s 2025-10-09 11:28:42.338 1285 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:40.826780617Z,type=ENTER_VALIDATION]
node1 2m 8.796s 2025-10-09 11:28:42.400 1282 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.722009082Z ]
node1 2m 8.797s 2025-10-09 11:28:42.401 1283 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:40.722009082Z,type=ENTER_VALIDATION]
node1 2m 8.797s 2025-10-09 11:28:42.401 1284 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.826780617Z ]
node1 2m 8.798s 2025-10-09 11:28:42.402 1285 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:40.826780617Z,type=ENTER_VALIDATION]
node2 2m 8.807s 2025-10-09 11:28:42.411 1282 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.722009082Z ]
node2 2m 8.807s 2025-10-09 11:28:42.411 1283 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:40.722009082Z,type=ENTER_VALIDATION]
node2 2m 8.808s 2025-10-09 11:28:42.412 1284 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.826780617Z ]
node2 2m 8.808s 2025-10-09 11:28:42.412 1285 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:40.826780617Z,type=ENTER_VALIDATION]
node0 2m 8.870s 2025-10-09 11:28:42.474 1282 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.722009082Z ]
node0 2m 8.870s 2025-10-09 11:28:42.474 1283 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:40.722009082Z,type=ENTER_VALIDATION]
node0 2m 8.871s 2025-10-09 11:28:42.475 1284 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:40.826780617Z ]
node0 2m 8.871s 2025-10-09 11:28:42.475 1285 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:40.826780617Z,type=ENTER_VALIDATION]
node3 2m 10.141s 2025-10-09 11:28:43.745 1306 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:41.746725976Z ]
node3 2m 10.141s 2025-10-09 11:28:43.745 1307 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:41.746725976Z,type=ENTER_VALIDATION]
node3 2m 10.143s 2025-10-09 11:28:43.747 1308 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node3 2m 10.145s 2025-10-09 11:28:43.749 1309 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node3 2m 10.169s 2025-10-09 11:28:43.773 1310 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1760009321746_746725976.json.gz
node1 2m 10.204s 2025-10-09 11:28:43.808 1306 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:41.746725976Z ]
node1 2m 10.205s 2025-10-09 11:28:43.809 1307 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:41.746725976Z,type=ENTER_VALIDATION]
node2 2m 10.205s 2025-10-09 11:28:43.809 1306 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:41.746725976Z ]
node1 2m 10.206s 2025-10-09 11:28:43.810 1308 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node2 2m 10.206s 2025-10-09 11:28:43.810 1307 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:41.746725976Z,type=ENTER_VALIDATION]
node2 2m 10.207s 2025-10-09 11:28:43.811 1308 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node1 2m 10.209s 2025-10-09 11:28:43.813 1309 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node2 2m 10.209s 2025-10-09 11:28:43.813 1309 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node2 2m 10.229s 2025-10-09 11:28:43.833 1310 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1760009321746_746725976.json.gz
node1 2m 10.231s 2025-10-09 11:28:43.835 1310 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1760009321746_746725976.json.gz
node0 2m 10.278s 2025-10-09 11:28:43.882 1306 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-09T11:28:41.746725976Z ]
node0 2m 10.279s 2025-10-09 11:28:43.883 1307 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:41.746725976Z,type=ENTER_VALIDATION]
node0 2m 10.279s 2025-10-09 11:28:43.883 1308 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node0 2m 10.281s 2025-10-09 11:28:43.885 1309 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node0 2m 10.300s 2025-10-09 11:28:43.904 1310 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1760009321746_746725976.json.gz
node3 2m 10.485s 2025-10-09 11:28:44.089 1311 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node3 2m 10.485s 2025-10-09 11:28:44.089 1312 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:41.746725976Z ]
node2 2m 10.527s 2025-10-09 11:28:44.131 1311 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node2 2m 10.528s 2025-10-09 11:28:44.132 1312 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:41.746725976Z ]
node1 2m 10.533s 2025-10-09 11:28:44.137 1311 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node1 2m 10.534s 2025-10-09 11:28:44.138 1312 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:41.746725976Z ]
node0 2m 10.603s 2025-10-09 11:28:44.207 1311 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1760009321746_746725976.json, consensusTime = 2025-10-09T11:28:41.746725976Z ]
node0 2m 10.604s 2025-10-09 11:28:44.208 1312 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:41.746725976Z ]
node3 2m 12.970s 2025-10-09 11:28:46.574 1333 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.566744486Z ]
node3 2m 12.971s 2025-10-09 11:28:46.575 1334 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:44.566744486Z,type=EXIT_VALIDATION]
node3 2m 12.972s 2025-10-09 11:28:46.576 1335 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.586382323Z ]
node3 2m 12.972s 2025-10-09 11:28:46.576 1336 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:44.586382323Z,type=EXIT_VALIDATION]
node3 2m 12.973s 2025-10-09 11:28:46.577 1337 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.641764701Z ]
node3 2m 12.973s 2025-10-09 11:28:46.577 1338 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:44.641764701Z,type=EXIT_VALIDATION]
node3 2m 12.973s 2025-10-09 11:28:46.577 1339 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.801738106Z ]
node3 2m 12.973s 2025-10-09 11:28:46.577 1340 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:44.801738106Z,type=EXIT_VALIDATION]
node3 2m 12.973s 2025-10-09 11:28:46.577 1341 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node3 2m 12.975s 2025-10-09 11:28:46.579 1342 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node3 2m 12.975s 2025-10-09 11:28:46.579 1345 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node3 2m 12.979s 2025-10-09 11:28:46.583 1348 INFO DEMO_INFO <<PTT: exit-validator 3>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-09T11:28:44.801738106Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 2m 13.024s 2025-10-09 11:28:46.628 1333 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.566744486Z ]
node1 2m 13.025s 2025-10-09 11:28:46.629 1334 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:44.566744486Z,type=EXIT_VALIDATION]
node1 2m 13.025s 2025-10-09 11:28:46.629 1335 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.586382323Z ]
node1 2m 13.026s 2025-10-09 11:28:46.630 1336 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:44.586382323Z,type=EXIT_VALIDATION]
node1 2m 13.026s 2025-10-09 11:28:46.630 1337 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.641764701Z ]
node1 2m 13.026s 2025-10-09 11:28:46.630 1338 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:44.641764701Z,type=EXIT_VALIDATION]
node1 2m 13.026s 2025-10-09 11:28:46.630 1339 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.801738106Z ]
node1 2m 13.026s 2025-10-09 11:28:46.630 1340 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:44.801738106Z,type=EXIT_VALIDATION]
node1 2m 13.027s 2025-10-09 11:28:46.631 1341 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node1 2m 13.028s 2025-10-09 11:28:46.632 1342 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node1 2m 13.028s 2025-10-09 11:28:46.632 1345 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node1 2m 13.030s 2025-10-09 11:28:46.634 1348 INFO DEMO_INFO <<PTT: exit-validator 1>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-09T11:28:44.801738106Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node2 2m 13.085s 2025-10-09 11:28:46.689 1333 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.566744486Z ]
node2 2m 13.086s 2025-10-09 11:28:46.690 1334 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:44.566744486Z,type=EXIT_VALIDATION]
node2 2m 13.087s 2025-10-09 11:28:46.691 1335 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.586382323Z ]
node2 2m 13.087s 2025-10-09 11:28:46.691 1336 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:44.586382323Z,type=EXIT_VALIDATION]
node2 2m 13.087s 2025-10-09 11:28:46.691 1337 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.641764701Z ]
node2 2m 13.087s 2025-10-09 11:28:46.691 1338 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:44.641764701Z,type=EXIT_VALIDATION]
node2 2m 13.088s 2025-10-09 11:28:46.692 1339 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.801738106Z ]
node2 2m 13.088s 2025-10-09 11:28:46.692 1340 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:44.801738106Z,type=EXIT_VALIDATION]
node2 2m 13.088s 2025-10-09 11:28:46.692 1341 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node2 2m 13.089s 2025-10-09 11:28:46.693 1342 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node2 2m 13.090s 2025-10-09 11:28:46.694 1345 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node2 2m 13.094s 2025-10-09 11:28:46.698 1348 INFO DEMO_INFO <<PTT: exit-validator 2>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-09T11:28:44.801738106Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 2m 13.098s 2025-10-09 11:28:46.702 1333 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.566744486Z ]
node0 2m 13.099s 2025-10-09 11:28:46.703 1334 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-10-09T11:28:44.566744486Z,type=EXIT_VALIDATION]
node0 2m 13.100s 2025-10-09 11:28:46.704 1335 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.586382323Z ]
node0 2m 13.100s 2025-10-09 11:28:46.704 1336 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-10-09T11:28:44.586382323Z,type=EXIT_VALIDATION]
node0 2m 13.100s 2025-10-09 11:28:46.704 1337 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.641764701Z ]
node0 2m 13.100s 2025-10-09 11:28:46.704 1338 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-10-09T11:28:44.641764701Z,type=EXIT_VALIDATION]
node0 2m 13.100s 2025-10-09 11:28:46.704 1339 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-09T11:28:44.801738106Z ]
node0 2m 13.100s 2025-10-09 11:28:46.704 1340 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-10-09T11:28:44.801738106Z,type=EXIT_VALIDATION]
node0 2m 13.101s 2025-10-09 11:28:46.705 1341 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node0 2m 13.101s 2025-10-09 11:28:46.705 1342 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node0 2m 13.103s 2025-10-09 11:28:46.707 1347 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 2m 13.103s 2025-10-09 11:28:46.707 1348 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 2m 13.103s 2025-10-09 11:28:46.707 1349 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-09T11:28:44.801738106Z ]
node0 2m 13.106s 2025-10-09 11:28:46.710 1350 INFO DEMO_INFO <<PTT: exit-validator 0>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-09T11:28:44.801738106Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 2m 15.076s 2025-10-09 11:28:48.680 1367 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1760009386
node3 2m 15.154s 2025-10-09 11:28:48.758 1365 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1760009386
node1 2m 15.163s 2025-10-09 11:28:48.767 1365 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1760009386
node2 2m 15.346s 2025-10-09 11:28:48.950 1365 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1760009386
node2 2m 59.258s 2025-10-09 11:29:32.862 1766 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.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 59.275s 2025-10-09 11:29:32.879 1767 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-09T11:29:32.878387528Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) 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-09T11:29:32.878387528Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:137) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 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.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:623) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more
node2 2m 59.297s 2025-10-09 11:29:32.901 1768 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-09T11:29:32.900766362Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) 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-09T11:29:32.900766362Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:137) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 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.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:623) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more
node1 2m 59.330s 2025-10-09 11:29:32.934 1766 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.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)
node3 2m 59.353s 2025-10-09 11:29:32.957 1766 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-09T11:29:32.949451189Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) 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-09T11:29:32.949451189Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 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.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readInt(DataInputStream.java:385) at org.hiero.base.io.streams.AugmentedDataInputStream.readInt(AugmentedDataInputStream.java:179) at org.hiero.base.io.streams.AugmentedDataInputStream.readBooleanList(AugmentedDataInputStream.java:359) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:159) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more
node0 2m 59.370s 2025-10-09 11:29:32.974 1768 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 0 to 2>> NetworkUtils: Connection broken: 0 -> 2
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-09T11:29:32.971399014Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) 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-09T11:29:32.971399014Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 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.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readInt(DataInputStream.java:385) at org.hiero.base.io.streams.AugmentedDataInputStream.readInt(AugmentedDataInputStream.java:179) at org.hiero.base.io.streams.AugmentedDataInputStream.readBooleanList(AugmentedDataInputStream.java:359) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:159) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more
node3 2m 59.623s 2025-10-09 11:29:33.227 1767 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.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 59.654s 2025-10-09 11:29:33.258 1768 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith0 3 to 0>> NetworkUtils: Connection broken: 3 <- 0
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-09T11:29:33.257983782Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) 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-09T11:29:33.257983782Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:217) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:184) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 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:272) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 11 more
node1 2m 59.698s 2025-10-09 11:29:33.302 1767 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.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.initiateHeartbeat(HeartbeatPeerProtocol.java:112) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.runProtocol(HeartbeatPeerProtocol.java:156) 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)
node0 2m 59.725s 2025-10-09 11:29:33.329 1769 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.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)
node2 3m 3.848s 2025-10-09 11:29:37.452 1769 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node2 3m 3.849s 2025-10-09 11:29:37.453 1770 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node1 3m 4.678s 2025-10-09 11:29:38.282 1768 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node1 3m 4.679s 2025-10-09 11:29:38.283 1769 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change CHECKING
node3 3m 4.753s 2025-10-09 11:29:38.357 1769 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node3 3m 4.755s 2025-10-09 11:29:38.359 1770 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change CHECKING
node0 3m 4.783s 2025-10-09 11:29:38.387 1770 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node0 3m 4.783s 2025-10-09 11:29:38.387 1771 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node3 3m 42.980s 2025-10-09 11:30:16.584 1771 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node3 3m 42.984s 2025-10-09 11:30:16.588 1772 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:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583)
node3 3m 42.986s 2025-10-09 11:30:16.590 1773 INFO STARTUP <<PTT: exit-validator 3>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node3 3m 42.988s 2025-10-09 11:30:16.592 1774 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node1 3m 43.031s 2025-10-09 11:30:16.635 1770 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node1 3m 43.034s 2025-10-09 11:30:16.638 1771 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:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583)
node1 3m 43.036s 2025-10-09 11:30:16.640 1772 INFO STARTUP <<PTT: exit-validator 1>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node1 3m 43.037s 2025-10-09 11:30:16.641 1773 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node2 3m 43.095s 2025-10-09 11:30:16.699 1771 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node2 3m 43.098s 2025-10-09 11:30:16.702 1772 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:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583)
node2 3m 43.100s 2025-10-09 11:30:16.704 1773 INFO STARTUP <<PTT: exit-validator 2>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node2 3m 43.102s 2025-10-09 11:30:16.706 1774 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node0 3m 43.106s 2025-10-09 11:30:16.710 1772 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-10-09T11:28:44.801738106Z ]
node0 3m 43.109s 2025-10-09 11:30:16.713 1773 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:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583)
node0 3m 43.111s 2025-10-09 11:30:16.715 1774 INFO STARTUP <<PTT: exit-validator 0>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node0 3m 43.112s 2025-10-09 11:30:16.716 1775 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.