Node ID






Columns











Log Level






Log Marker










Class












































node2 0.000ns 2025-09-25 11:17:57.854 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 89.000ms 2025-09-25 11:17:57.943 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 219.000ms 2025-09-25 11:17:58.073 3 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 226.000ms 2025-09-25 11:17:58.080 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 255.000ms 2025-09-25 11:17:58.109 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 256.000ms 2025-09-25 11:17:58.110 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 257.000ms 2025-09-25 11:17:58.111 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 258.000ms 2025-09-25 11:17:58.112 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 258.000ms 2025-09-25 11:17:58.112 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 258.000ms 2025-09-25 11:17:58.112 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 259.000ms 2025-09-25 11:17:58.113 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 260.000ms 2025-09-25 11:17:58.114 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 260.000ms 2025-09-25 11:17:58.114 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 260.000ms 2025-09-25 11:17:58.114 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 261.000ms 2025-09-25 11:17:58.115 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 261.000ms 2025-09-25 11:17:58.115 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 261.000ms 2025-09-25 11:17:58.115 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 262.000ms 2025-09-25 11:17:58.116 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 262.000ms 2025-09-25 11:17:58.116 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 674.000ms 2025-09-25 11:17:58.528 22 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 795.000ms 2025-09-25 11:17:58.649 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node3 881.000ms 2025-09-25 11:17:58.735 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 1.010s 2025-09-25 11:17:58.864 3 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 1.017s 2025-09-25 11:17:58.871 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 1.045s 2025-09-25 11:17:58.899 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.046s 2025-09-25 11:17:58.900 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.047s 2025-09-25 11:17:58.901 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.048s 2025-09-25 11:17:58.902 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.048s 2025-09-25 11:17:58.902 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.049s 2025-09-25 11:17:58.903 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.049s 2025-09-25 11:17:58.903 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.050s 2025-09-25 11:17:58.904 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.050s 2025-09-25 11:17:58.904 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.051s 2025-09-25 11:17:58.905 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.051s 2025-09-25 11:17:58.905 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.051s 2025-09-25 11:17:58.905 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.052s 2025-09-25 11:17:58.906 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.052s 2025-09-25 11:17:58.906 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.053s 2025-09-25 11:17:58.907 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 1.302s 2025-09-25 11:17:59.156 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 1.353s 2025-09-25 11:17:59.207 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 1.398s 2025-09-25 11:17:59.252 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 1.451s 2025-09-25 11:17:59.305 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 1.458s 2025-09-25 11:17:59.312 22 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node0 1.536s 2025-09-25 11:17:59.390 3 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 1.544s 2025-09-25 11:17:59.398 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 1.563s 2025-09-25 11:17:59.417 23 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 888ms
node0 1.575s 2025-09-25 11:17:59.429 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.577s 2025-09-25 11:17:59.431 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.577s 2025-09-25 11:17:59.431 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.578s 2025-09-25 11:17:59.432 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.579s 2025-09-25 11:17:59.433 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.579s 2025-09-25 11:17:59.433 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.580s 2025-09-25 11:17:59.434 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.581s 2025-09-25 11:17:59.435 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.581s 2025-09-25 11:17:59.435 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.582s 2025-09-25 11:17:59.436 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.582s 2025-09-25 11:17:59.436 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.582s 2025-09-25 11:17:59.436 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.583s 2025-09-25 11:17:59.437 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.583s 2025-09-25 11:17:59.437 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.583s 2025-09-25 11:17:59.437 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 1.589s 2025-09-25 11:17:59.443 3 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node1 1.597s 2025-09-25 11:17:59.451 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 1.612s 2025-09-25 11:17:59.466 24 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 1.627s 2025-09-25 11:17:59.481 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 1.628s 2025-09-25 11:17:59.482 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.629s 2025-09-25 11:17:59.483 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.629s 2025-09-25 11:17:59.483 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.630s 2025-09-25 11:17:59.484 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.630s 2025-09-25 11:17:59.484 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.631s 2025-09-25 11:17:59.485 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.631s 2025-09-25 11:17:59.485 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 1.632s 2025-09-25 11:17:59.486 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 1.632s 2025-09-25 11:17:59.486 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 1.633s 2025-09-25 11:17:59.487 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 1.633s 2025-09-25 11:17:59.487 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 1.633s 2025-09-25 11:17:59.487 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 1.634s 2025-09-25 11:17:59.488 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 1.634s 2025-09-25 11:17:59.488 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 1.682s 2025-09-25 11:17:59.536 25 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 1.682s 2025-09-25 11:17:59.536 26 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 2.007s 2025-09-25 11:17:59.861 22 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node1 2.077s 2025-09-25 11:17:59.931 22 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 2.414s 2025-09-25 11:18:00.268 23 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 955ms
node3 2.472s 2025-09-25 11:18:00.326 24 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 2.545s 2025-09-25 11:18:00.399 25 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 2.547s 2025-09-25 11:18:00.401 26 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 3.064s 2025-09-25 11:18:00.918 23 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1056ms
node0 3.115s 2025-09-25 11:18:00.969 24 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 3.174s 2025-09-25 11:18:01.028 23 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1096ms
node0 3.177s 2025-09-25 11:18:01.031 25 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 3.177s 2025-09-25 11:18:01.031 26 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 3.233s 2025-09-25 11:18:01.087 24 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 3.303s 2025-09-25 11:18:01.157 25 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 3.304s 2025-09-25 11:18:01.158 26 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node2 3.717s 2025-09-25 11:18:01.571 27 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 3.801s 2025-09-25 11:18:01.655 30 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 3.802s 2025-09-25 11:18:01.656 31 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 3.802s 2025-09-25 11:18:01.656 32 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 3.803s 2025-09-25 11:18:01.657 33 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 3.803s 2025-09-25 11:18:01.657 34 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 3.803s 2025-09-25 11:18:01.657 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 3.803s 2025-09-25 11:18:01.657 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 3.803s 2025-09-25 11:18:01.657 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 4.583s 2025-09-25 11:18:02.437 47 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 4.588s 2025-09-25 11:18:02.442 48 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 4.602s 2025-09-25 11:18:02.456 27 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 4.679s 2025-09-25 11:18:02.533 30 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 4.680s 2025-09-25 11:18:02.534 31 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 4.681s 2025-09-25 11:18:02.535 32 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 4.681s 2025-09-25 11:18:02.535 33 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 4.681s 2025-09-25 11:18:02.535 34 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 4.681s 2025-09-25 11:18:02.535 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 4.682s 2025-09-25 11:18:02.536 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 4.682s 2025-09-25 11:18:02.536 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 5.189s 2025-09-25 11:18:03.043 27 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 5.268s 2025-09-25 11:18:03.122 30 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 5.269s 2025-09-25 11:18:03.123 31 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 5.269s 2025-09-25 11:18:03.123 32 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 5.270s 2025-09-25 11:18:03.124 33 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 5.270s 2025-09-25 11:18:03.124 34 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 5.270s 2025-09-25 11:18:03.124 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 5.270s 2025-09-25 11:18:03.124 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 5.270s 2025-09-25 11:18:03.124 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 5.338s 2025-09-25 11:18:03.192 27 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node1 5.425s 2025-09-25 11:18:03.279 30 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 5.426s 2025-09-25 11:18:03.280 31 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 5.426s 2025-09-25 11:18:03.280 32 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 5.426s 2025-09-25 11:18:03.280 33 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 5.427s 2025-09-25 11:18:03.281 34 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 5.427s 2025-09-25 11:18:03.281 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 5.427s 2025-09-25 11:18:03.281 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 5.427s 2025-09-25 11:18:03.281 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 5.476s 2025-09-25 11:18:03.330 47 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node3 5.482s 2025-09-25 11:18:03.336 48 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 5.700s 2025-09-25 11:18:03.554 49 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26240332] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=166870, randomLong=-2088715087203618803, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=18940, randomLong=-8486266459148522792, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1242000, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms)
node2 5.728s 2025-09-25 11:18:03.582 50 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node2 5.735s 2025-09-25 11:18:03.589 51 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 5.740s 2025-09-25 11:18:03.594 52 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 5.816s 2025-09-25 11:18:03.670 53 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IofgCw==", "port": 30124 }, { "ipAddressV4": "CoAAIg==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IkYzSA==", "port": 30125 }, { "ipAddressV4": "CoAAHQ==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I983sg==", "port": 30126 }, { "ipAddressV4": "CoAAIQ==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "I+6Cvg==", "port": 30127 }, { "ipAddressV4": "CoAAHA==", "port": 30127 }] }] }
node2 5.910s 2025-09-25 11:18:03.764 54 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 5.911s 2025-09-25 11:18:03.765 55 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 5.926s 2025-09-25 11:18:03.780 56 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: d3916c9ba736c343d09c6cb89380b9fa2bd69f05fcc20d809cba35e1ab9027df34079c385b311ee1827b53db02d68bc1 (root) PlatformTestingToolState / mistake-nature-bone-nut 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 6.120s 2025-09-25 11:18:03.974 58 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 6.124s 2025-09-25 11:18:03.978 59 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 6.133s 2025-09-25 11:18:03.987 60 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 6.133s 2025-09-25 11:18:03.987 61 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 6.134s 2025-09-25 11:18:03.988 62 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 6.134s 2025-09-25 11:18:03.988 63 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 6.134s 2025-09-25 11:18:03.988 64 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 6.135s 2025-09-25 11:18:03.989 65 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 6.135s 2025-09-25 11:18:03.989 66 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 6.135s 2025-09-25 11:18:03.989 67 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 6.135s 2025-09-25 11:18:03.989 68 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 6.136s 2025-09-25 11:18:03.990 69 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 6.136s 2025-09-25 11:18:03.990 70 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 6.136s 2025-09-25 11:18:03.990 71 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 6.137s 2025-09-25 11:18:03.991 72 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 6.137s 2025-09-25 11:18:03.991 73 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 6.137s 2025-09-25 11:18:03.991 74 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 6.144s 2025-09-25 11:18:03.998 47 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 6.151s 2025-09-25 11:18:04.005 48 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 6.153s 2025-09-25 11:18:04.007 75 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 6.154s 2025-09-25 11:18:04.008 76 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 6.154s 2025-09-25 11:18:04.008 77 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 6.154s 2025-09-25 11:18:04.008 78 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 6.155s 2025-09-25 11:18:04.009 79 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 6.155s 2025-09-25 11:18:04.009 80 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node2 6.156s 2025-09-25 11:18:04.010 81 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 6.157s 2025-09-25 11:18:04.011 82 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node2 6.162s 2025-09-25 11:18:04.016 83 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@446b80d8
node2 6.163s 2025-09-25 11:18:04.017 84 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 80000
node2 6.163s 2025-09-25 11:18:04.017 85 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node2 6.170s 2025-09-25 11:18:04.024 90 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@45513ff5, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1f332302,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@647cdb76,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@b567b80,snapshotInProgress=false]
node2 6.178s 2025-09-25 11:18:04.032 91 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 6.178s 2025-09-25 11:18:04.032 92 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 6.182s 2025-09-25 11:18:04.036 93 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is 7725520878096796079
node2 6.183s 2025-09-25 11:18:04.037 94 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node2 6.262s 2025-09-25 11:18:04.116 95 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node2 6.264s 2025-09-25 11:18:04.118 96 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 6.267s 2025-09-25 11:18:04.121 97 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 6.268s 2025-09-25 11:18:04.122 98 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 6.268s 2025-09-25 11:18:04.122 99 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 6.270s 2025-09-25 11:18:04.124 100 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node2 6.270s 2025-09-25 11:18:04.124 101 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 6.271s 2025-09-25 11:18:04.125 102 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 6.273s 2025-09-25 11:18:04.127 103 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 295.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 6.273s 2025-09-25 11:18:04.127 104 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 6.273s 2025-09-25 11:18:04.127 105 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 6.278s 2025-09-25 11:18:04.132 106 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 6.278s 2025-09-25 11:18:04.132 107 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 6.304s 2025-09-25 11:18:04.158 47 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 6.310s 2025-09-25 11:18:04.164 48 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 6.594s 2025-09-25 11:18:04.448 49 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26224633] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=170800, randomLong=9186351186589934623, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9700, randomLong=-6951180580314354091, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=975889, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms)
node3 6.622s 2025-09-25 11:18:04.476 50 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 6.630s 2025-09-25 11:18:04.484 51 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 6.634s 2025-09-25 11:18:04.488 52 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 6.716s 2025-09-25 11:18:04.570 53 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IofgCw==", "port": 30124 }, { "ipAddressV4": "CoAAIg==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IkYzSA==", "port": 30125 }, { "ipAddressV4": "CoAAHQ==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I983sg==", "port": 30126 }, { "ipAddressV4": "CoAAIQ==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "I+6Cvg==", "port": 30127 }, { "ipAddressV4": "CoAAHA==", "port": 30127 }] }] }
node3 6.820s 2025-09-25 11:18:04.674 54 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 6.821s 2025-09-25 11:18:04.675 55 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 6.837s 2025-09-25 11:18:04.691 56 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: d3916c9ba736c343d09c6cb89380b9fa2bd69f05fcc20d809cba35e1ab9027df34079c385b311ee1827b53db02d68bc1 (root) PlatformTestingToolState / mistake-nature-bone-nut 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 7.031s 2025-09-25 11:18:04.885 58 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 7.038s 2025-09-25 11:18:04.892 59 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 7.051s 2025-09-25 11:18:04.905 60 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 7.051s 2025-09-25 11:18:04.905 61 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 7.052s 2025-09-25 11:18:04.906 62 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 7.052s 2025-09-25 11:18:04.906 63 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 7.052s 2025-09-25 11:18:04.906 64 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 7.053s 2025-09-25 11:18:04.907 65 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 7.053s 2025-09-25 11:18:04.907 66 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 7.053s 2025-09-25 11:18:04.907 67 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 7.054s 2025-09-25 11:18:04.908 68 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 7.054s 2025-09-25 11:18:04.908 69 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 7.054s 2025-09-25 11:18:04.908 70 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 7.055s 2025-09-25 11:18:04.909 71 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 7.055s 2025-09-25 11:18:04.909 72 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 7.055s 2025-09-25 11:18:04.909 73 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 7.056s 2025-09-25 11:18:04.910 74 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node3 7.073s 2025-09-25 11:18:04.927 75 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 7.073s 2025-09-25 11:18:04.927 76 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 7.074s 2025-09-25 11:18:04.928 77 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 7.074s 2025-09-25 11:18:04.928 78 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 7.075s 2025-09-25 11:18:04.929 79 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 7.075s 2025-09-25 11:18:04.929 80 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node3 7.076s 2025-09-25 11:18:04.930 81 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 7.077s 2025-09-25 11:18:04.931 82 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node3 7.082s 2025-09-25 11:18:04.936 83 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@27cbeb6f
node3 7.083s 2025-09-25 11:18:04.937 84 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 80000
node3 7.084s 2025-09-25 11:18:04.938 85 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node3 7.091s 2025-09-25 11:18:04.945 90 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@4e8b8b7c, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@3dc7a670,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@1b6b7609,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@76781b39,snapshotInProgress=false]
node3 7.099s 2025-09-25 11:18:04.953 91 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 7.099s 2025-09-25 11:18:04.953 92 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 7.103s 2025-09-25 11:18:04.957 93 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is 2470732913522290844
node3 7.104s 2025-09-25 11:18:04.958 94 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 7.180s 2025-09-25 11:18:05.034 95 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 7.182s 2025-09-25 11:18:05.036 96 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 7.186s 2025-09-25 11:18:05.040 97 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 7.187s 2025-09-25 11:18:05.041 98 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 7.188s 2025-09-25 11:18:05.042 99 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 7.190s 2025-09-25 11:18:05.044 100 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 7.190s 2025-09-25 11:18:05.044 101 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 7.192s 2025-09-25 11:18:05.046 102 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 7.193s 2025-09-25 11:18:05.047 103 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 304.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 7.193s 2025-09-25 11:18:05.047 104 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 7.193s 2025-09-25 11:18:05.047 105 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 7.198s 2025-09-25 11:18:05.052 106 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 7.198s 2025-09-25 11:18:05.052 107 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 7.305s 2025-09-25 11:18:05.159 49 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26292325] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=175440, randomLong=-5141053691622046429, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=12120, randomLong=-422011132333674703, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=976910, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms)
node0 7.337s 2025-09-25 11:18:05.191 50 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 7.344s 2025-09-25 11:18:05.198 51 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 7.350s 2025-09-25 11:18:05.204 52 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 7.431s 2025-09-25 11:18:05.285 53 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IofgCw==", "port": 30124 }, { "ipAddressV4": "CoAAIg==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IkYzSA==", "port": 30125 }, { "ipAddressV4": "CoAAHQ==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I983sg==", "port": 30126 }, { "ipAddressV4": "CoAAIQ==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "I+6Cvg==", "port": 30127 }, { "ipAddressV4": "CoAAHA==", "port": 30127 }] }] }
node1 7.441s 2025-09-25 11:18:05.295 49 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26303285] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=179671, randomLong=-4726935646964017827, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=17731, randomLong=247765191669403668, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1584110, data=35, exception=null] OS Health Check Report - Complete (took 1025 ms)
node1 7.473s 2025-09-25 11:18:05.327 50 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 7.483s 2025-09-25 11:18:05.337 51 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 7.490s 2025-09-25 11:18:05.344 52 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 7.540s 2025-09-25 11:18:05.394 54 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 7.541s 2025-09-25 11:18:05.395 55 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 7.557s 2025-09-25 11:18:05.411 56 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: d3916c9ba736c343d09c6cb89380b9fa2bd69f05fcc20d809cba35e1ab9027df34079c385b311ee1827b53db02d68bc1 (root) PlatformTestingToolState / mistake-nature-bone-nut 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 7.581s 2025-09-25 11:18:05.435 53 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IofgCw==", "port": 30124 }, { "ipAddressV4": "CoAAIg==", "port": 30124 }] }, { "nodeId": "1", "weight": "15745067016", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IkYzSA==", "port": 30125 }, { "ipAddressV4": "CoAAHQ==", "port": 30125 }] }, { "nodeId": "2", "weight": "15152326407", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I983sg==", "port": 30126 }, { "ipAddressV4": "CoAAIQ==", "port": 30126 }] }, { "nodeId": "3", "weight": "16416969660", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "I+6Cvg==", "port": 30127 }, { "ipAddressV4": "CoAAHA==", "port": 30127 }] }] }
node1 7.688s 2025-09-25 11:18:05.542 54 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 7.688s 2025-09-25 11:18:05.542 55 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 7.708s 2025-09-25 11:18:05.562 56 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: d3916c9ba736c343d09c6cb89380b9fa2bd69f05fcc20d809cba35e1ab9027df34079c385b311ee1827b53db02d68bc1 (root) PlatformTestingToolState / mistake-nature-bone-nut 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 7.794s 2025-09-25 11:18:05.648 58 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 7.799s 2025-09-25 11:18:05.653 59 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 7.809s 2025-09-25 11:18:05.663 60 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 7.810s 2025-09-25 11:18:05.664 61 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 7.810s 2025-09-25 11:18:05.664 62 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 7.811s 2025-09-25 11:18:05.665 63 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 7.811s 2025-09-25 11:18:05.665 64 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 7.811s 2025-09-25 11:18:05.665 65 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 7.811s 2025-09-25 11:18:05.665 66 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 7.812s 2025-09-25 11:18:05.666 67 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 7.812s 2025-09-25 11:18:05.666 68 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 7.812s 2025-09-25 11:18:05.666 69 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 7.813s 2025-09-25 11:18:05.667 70 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 7.813s 2025-09-25 11:18:05.667 71 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 7.813s 2025-09-25 11:18:05.667 72 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 7.813s 2025-09-25 11:18:05.667 73 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 7.814s 2025-09-25 11:18:05.668 74 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 7.833s 2025-09-25 11:18:05.687 75 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 7.834s 2025-09-25 11:18:05.688 76 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 7.834s 2025-09-25 11:18:05.688 77 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 7.834s 2025-09-25 11:18:05.688 78 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 7.835s 2025-09-25 11:18:05.689 79 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 7.836s 2025-09-25 11:18:05.690 80 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node0 7.837s 2025-09-25 11:18:05.691 81 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 7.839s 2025-09-25 11:18:05.693 82 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node0 7.845s 2025-09-25 11:18:05.699 83 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@14aebb5f
node0 7.846s 2025-09-25 11:18:05.700 84 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 80000
node0 7.846s 2025-09-25 11:18:05.700 85 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node0 7.854s 2025-09-25 11:18:05.708 90 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@b590a48, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@76f7b186,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@20277fb4,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@106b4dfa,snapshotInProgress=false]
node0 7.864s 2025-09-25 11:18:05.718 91 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 7.865s 2025-09-25 11:18:05.719 92 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 7.870s 2025-09-25 11:18:05.724 93 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is -4509063426030624108
node0 7.871s 2025-09-25 11:18:05.725 94 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 7.948s 2025-09-25 11:18:05.802 58 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 7.954s 2025-09-25 11:18:05.808 59 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 7.967s 2025-09-25 11:18:05.821 60 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 7.968s 2025-09-25 11:18:05.822 61 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 7.968s 2025-09-25 11:18:05.822 62 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 7.969s 2025-09-25 11:18:05.823 95 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node1 7.969s 2025-09-25 11:18:05.823 63 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 7.969s 2025-09-25 11:18:05.823 64 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 7.970s 2025-09-25 11:18:05.824 65 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 7.970s 2025-09-25 11:18:05.824 66 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 7.970s 2025-09-25 11:18:05.824 67 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 7.971s 2025-09-25 11:18:05.825 68 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 7.971s 2025-09-25 11:18:05.825 69 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 7.971s 2025-09-25 11:18:05.825 70 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 7.971s 2025-09-25 11:18:05.825 71 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 7.972s 2025-09-25 11:18:05.826 96 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 7.972s 2025-09-25 11:18:05.826 72 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 7.972s 2025-09-25 11:18:05.826 73 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 7.972s 2025-09-25 11:18:05.826 74 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 7.975s 2025-09-25 11:18:05.829 97 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 7.976s 2025-09-25 11:18:05.830 98 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 7.977s 2025-09-25 11:18:05.831 99 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 7.979s 2025-09-25 11:18:05.833 100 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 7.979s 2025-09-25 11:18:05.833 101 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 7.981s 2025-09-25 11:18:05.835 102 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 7.982s 2025-09-25 11:18:05.836 103 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 7.985s 2025-09-25 11:18:05.839 104 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 370.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 7.986s 2025-09-25 11:18:05.840 105 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 7.991s 2025-09-25 11:18:05.845 106 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 7.992s 2025-09-25 11:18:05.846 107 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 7.993s 2025-09-25 11:18:05.847 75 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 7.994s 2025-09-25 11:18:05.848 76 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 7.994s 2025-09-25 11:18:05.848 77 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 7.994s 2025-09-25 11:18:05.848 78 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 7.995s 2025-09-25 11:18:05.849 79 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 7.996s 2025-09-25 11:18:05.850 80 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node1 7.996s 2025-09-25 11:18:05.850 81 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 7.998s 2025-09-25 11:18:05.852 82 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node1 8.005s 2025-09-25 11:18:05.859 83 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@427c92db
node1 8.007s 2025-09-25 11:18:05.861 84 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 80000
node1 8.007s 2025-09-25 11:18:05.861 85 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node1 8.016s 2025-09-25 11:18:05.870 90 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@2ee6213b, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6a721770,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@49c7833f,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@181da059,snapshotInProgress=false]
node1 8.026s 2025-09-25 11:18:05.880 91 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 8.026s 2025-09-25 11:18:05.880 92 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 8.032s 2025-09-25 11:18:05.886 93 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is -35364548670819437
node1 8.033s 2025-09-25 11:18:05.887 94 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node1 8.129s 2025-09-25 11:18:05.983 95 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 8.132s 2025-09-25 11:18:05.986 96 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 8.136s 2025-09-25 11:18:05.990 97 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 8.138s 2025-09-25 11:18:05.992 98 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 8.139s 2025-09-25 11:18:05.993 99 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 8.141s 2025-09-25 11:18:05.995 100 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 8.141s 2025-09-25 11:18:05.995 101 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 8.143s 2025-09-25 11:18:05.997 102 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.145s 2025-09-25 11:18:05.999 103 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 8.148s 2025-09-25 11:18:06.002 104 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 378.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 8.149s 2025-09-25 11:18:06.003 105 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 8.155s 2025-09-25 11:18:06.009 106 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 8.156s 2025-09-25 11:18:06.010 107 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 9.142s 2025-09-25 11:18:06.996 108 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 9.145s 2025-09-25 11:18:06.999 109 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 10.061s 2025-09-25 11:18:07.915 108 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ]
node3 10.064s 2025-09-25 11:18:07.918 109 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 10.817s 2025-09-25 11:18:08.671 108 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ]
node0 10.819s 2025-09-25 11:18:08.673 109 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 10.977s 2025-09-25 11:18:08.831 108 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting1.csv' ]
node1 10.980s 2025-09-25 11:18:08.834 109 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node2 16.371s 2025-09-25 11:18:14.225 110 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 16.372s 2025-09-25 11:18:14.226 111 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node3 17.289s 2025-09-25 11:18:15.143 110 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 17.290s 2025-09-25 11:18:15.144 111 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node0 18.078s 2025-09-25 11:18:15.932 110 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 18.079s 2025-09-25 11:18:15.933 111 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change CHECKING
node1 18.240s 2025-09-25 11:18:16.094 110 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 18.241s 2025-09-25 11:18:16.095 111 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node0 19.514s 2025-09-25 11:18:17.368 112 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 19.789s 2025-09-25 11:18:17.643 112 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 19.942s 2025-09-25 11:18:17.796 112 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node2 19.946s 2025-09-25 11:18:17.800 112 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node2 19.946s 2025-09-25 11:18:17.800 113 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 3.6 s in CHECKING. Now in ACTIVE
node2 19.948s 2025-09-25 11:18:17.802 114 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 19.990s 2025-09-25 11:18:17.844 115 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x1C9C05582F07ED713ED78933CCEE1D187229FE46310A568AADC0D60AED887646', privateKey ='0x1C9C05582F07ED713ED78933CCEE1D187229FE46310A568AADC0D60AED887646', signature = '0x26C16B5C220C0D464A0B17FD1B7B6155B1EA5FCEA1AB80640D340E8039547B3E2C298BE10A4E66EEFE000FC608DFD8BDBDFD5CF46F421258A29EACA040150A09',message = '0x12660A1E080210021880E2092080E2092880E2093080E20940B0919EF198FD96EC6D32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003802' }
node0 20.296s 2025-09-25 11:18:18.150 113 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.2 s in CHECKING. Now in ACTIVE
node0 20.297s 2025-09-25 11:18:18.151 114 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 20.308s 2025-09-25 11:18:18.162 113 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 3.0 s in CHECKING. Now in ACTIVE
node3 20.309s 2025-09-25 11:18:18.163 114 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 20.343s 2025-09-25 11:18:18.197 115 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x7A0D6E4469AF685091CEDFA69458F72F907547DF74D0243483172D73163831B4', privateKey ='0x7A0D6E4469AF685091CEDFA69458F72F907547DF74D0243483172D73163831B4', signature = '0xE425FE0D38FB9FEDBA0B76E95A2A5165E75E3500B59A04B3E81319F8BFD45043F15F3E6472A46F9DDF7D7D0038A4186F8335E8278E1B13E8994BD72F0A72650B',message = '0x12660A0A40A6A2B19CAC8487C566325800000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' }
node3 20.346s 2025-09-25 11:18:18.200 115 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xD7531CF3D2A40203B4785D1F062505F5D25D0728BF3898F52E9E4E91B14BB8D1', privateKey ='0xD7531CF3D2A40203B4785D1F062505F5D25D0728BF3898F52E9E4E91B14BB8D1', signature = '0x3FA206FEDE1DCA66F6D7E9F2D82CE31F6B9F12C7F6A366F0183EA0790D7FAEB983598B8C6735151B35A0E2EAB1DE8205535E6ABE1CF593E6D995A0A696EDDF05',message = '0x12660A1E080310031880D30E2080D30E2880D30E3080D30E40FBFAE2C8BDDDF4B53832420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003803' }
node0 21.351s 2025-09-25 11:18:19.205 118 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.493s 2025-09-25 11:18:19.347 118 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.684s 2025-09-25 11:18:19.538 118 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.711s 2025-09-25 11:18:19.565 113 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 3.5 s in CHECKING. Now in ACTIVE
node1 21.712s 2025-09-25 11:18:19.566 115 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 21.714s 2025-09-25 11:18:19.568 117 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.733s 2025-09-25 11:18:19.587 132 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xF1FABC0D6ECC6DD86411E6F434C887396AE3FAB7B860A3348AEFC579690246C6', privateKey ='0xF1FABC0D6ECC6DD86411E6F434C887396AE3FAB7B860A3348AEFC579690246C6', signature = '0x7206D8697D7C09DD9F662DD510A1B68C396C76CBF580500566A478DAF36B41D0AA6571A4CEB1746DFAFDD81F9017FDFF1FE4CADC629520909A7C43063855EF05',message = '0x12660A1E080110011880F1042080F1042880F1043080F10440ECCBB1B8B4CECDF50D32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003801' }
node0 22.125s 2025-09-25 11:18:19.979 133 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.127s 2025-09-25 11:18:19.981 134 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.198s 2025-09-25 11:18:20.052 133 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.200s 2025-09-25 11:18:20.054 134 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.245s 2025-09-25 11:18:20.099 133 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
node2 22.246s 2025-09-25 11:18:20.100 133 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
node1 22.247s 2025-09-25 11:18:20.101 134 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node2 22.248s 2025-09-25 11:18:20.102 134 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.398s 2025-09-25 11:18:20.252 191 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.401s 2025-09-25 11:18:20.255 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-25T11:18:17.374056353Z Next consensus number: 23 Legacy running event hash: 8d052b0f8544d589c52579ffe66a5103737bc59e7533afeaa0af511480b8f7a210cc6059c238f0760575296e74922288 Legacy running event mnemonic: garage-giggle-fiscal-exclude Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 8e50d1a3b7547bab39cb288af10ca7d3564bb68959571aa46111b8b7a78a5147c64df2858aa67228b3e3f36ff7469a19 (root) PlatformTestingToolState / current-slight-better-install 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tonight-enrich-dragon-lens 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 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
node0 22.436s 2025-09-25 11:18:20.290 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/09/25/2025-09-25T11+18+14.615854981Z_seq0_minr1_maxr501_orgn0.pces
node0 22.437s 2025-09-25 11:18:20.291 194 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/09/25/2025-09-25T11+18+14.615854981Z_seq0_minr1_maxr501_orgn0.pces
node0 22.437s 2025-09-25 11:18:20.291 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 22.439s 2025-09-25 11:18:20.293 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 22.444s 2025-09-25 11:18:20.298 197 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.495s 2025-09-25 11:18:20.349 191 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.499s 2025-09-25 11:18:20.353 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-25T11:18:17.374056353Z Next consensus number: 23 Legacy running event hash: 8d052b0f8544d589c52579ffe66a5103737bc59e7533afeaa0af511480b8f7a210cc6059c238f0760575296e74922288 Legacy running event mnemonic: garage-giggle-fiscal-exclude Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 8e50d1a3b7547bab39cb288af10ca7d3564bb68959571aa46111b8b7a78a5147c64df2858aa67228b3e3f36ff7469a19 (root) PlatformTestingToolState / current-slight-better-install 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tonight-enrich-dragon-lens 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 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.504s 2025-09-25 11:18:20.358 191 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.507s 2025-09-25 11:18:20.361 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-25T11:18:17.374056353Z Next consensus number: 23 Legacy running event hash: 8d052b0f8544d589c52579ffe66a5103737bc59e7533afeaa0af511480b8f7a210cc6059c238f0760575296e74922288 Legacy running event mnemonic: garage-giggle-fiscal-exclude Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 8e50d1a3b7547bab39cb288af10ca7d3564bb68959571aa46111b8b7a78a5147c64df2858aa67228b3e3f36ff7469a19 (root) PlatformTestingToolState / current-slight-better-install 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tonight-enrich-dragon-lens 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 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.530s 2025-09-25 11:18:20.384 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/09/25/2025-09-25T11+18+14.508593900Z_seq0_minr1_maxr501_orgn0.pces
node3 22.531s 2025-09-25 11:18:20.385 194 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/09/25/2025-09-25T11+18+14.508593900Z_seq0_minr1_maxr501_orgn0.pces
node3 22.531s 2025-09-25 11:18:20.385 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 22.533s 2025-09-25 11:18:20.387 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 22.536s 2025-09-25 11:18:20.390 191 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.538s 2025-09-25 11:18:20.392 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node1 22.540s 2025-09-25 11:18:20.394 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-25T11:18:17.374056353Z Next consensus number: 23 Legacy running event hash: 8d052b0f8544d589c52579ffe66a5103737bc59e7533afeaa0af511480b8f7a210cc6059c238f0760575296e74922288 Legacy running event mnemonic: garage-giggle-fiscal-exclude Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 8e50d1a3b7547bab39cb288af10ca7d3564bb68959571aa46111b8b7a78a5147c64df2858aa67228b3e3f36ff7469a19 (root) PlatformTestingToolState / current-slight-better-install 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tonight-enrich-dragon-lens 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 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.545s 2025-09-25 11:18:20.399 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/09/25/2025-09-25T11+18+14.270453499Z_seq0_minr1_maxr501_orgn0.pces
node2 22.545s 2025-09-25 11:18:20.399 194 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/09/25/2025-09-25T11+18+14.270453499Z_seq0_minr1_maxr501_orgn0.pces
node2 22.546s 2025-09-25 11:18:20.400 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 22.548s 2025-09-25 11:18:20.402 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 22.553s 2025-09-25 11:18:20.407 197 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]
node1 22.577s 2025-09-25 11:18:20.431 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/09/25/2025-09-25T11+18+14.730307677Z_seq0_minr1_maxr501_orgn0.pces
node1 22.578s 2025-09-25 11:18:20.432 194 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/09/25/2025-09-25T11+18+14.730307677Z_seq0_minr1_maxr501_orgn0.pces
node1 22.578s 2025-09-25 11:18:20.432 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 22.581s 2025-09-25 11:18:20.435 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 22.586s 2025-09-25 11:18:20.440 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 1m 39.992s 2025-09-25 11:19:37.846 978 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 1m 40.368s 2025-09-25 11:19:38.222 978 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 40.391s 2025-09-25 11:19:38.245 978 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 41.767s 2025-09-25 11:19:39.621 998 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 7.000m 2025-09-25 11:24:57.870 4123 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 7.000m 2025-09-25 11:24:57.872 4124 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 7.000m 2025-09-25 11:24:57.875 4125 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 7.000m 2025-09-25 11:24:57.875 4126 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node0 7.006m 2025-09-25 11:24:58.234 4139 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 7.006m 2025-09-25 11:24:58.236 4140 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node3 7.006m 2025-09-25 11:24:58.238 4139 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 7.006m 2025-09-25 11:24:58.239 4141 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 7.006m 2025-09-25 11:24:58.239 4142 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node3 7.006m 2025-09-25 11:24:58.241 4140 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 7.006m 2025-09-25 11:24:58.244 4141 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 7.006m 2025-09-25 11:24:58.244 4142 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node1 7m 1.772s 2025-09-25 11:24:59.626 4143 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 7m 1.775s 2025-09-25 11:24:59.629 4144 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 7m 1.776s 2025-09-25 11:24:59.630 4145 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 7m 1.776s 2025-09-25 11:24:59.630 4146 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node1 7m 2.250s 2025-09-25 11:25:00.104 4147 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.322851087Z ]
node1 7m 2.251s 2025-09-25 11:25:00.105 4148 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:24:58.322851087Z,type=ENTER_VALIDATION]
node1 7m 2.254s 2025-09-25 11:25:00.108 4149 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.502018Z ]
node1 7m 2.254s 2025-09-25 11:25:00.108 4150 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:24:58.502018Z,type=ENTER_VALIDATION]
node0 7m 2.267s 2025-09-25 11:25:00.121 4163 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.322851087Z ]
node0 7m 2.267s 2025-09-25 11:25:00.121 4164 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:24:58.322851087Z,type=ENTER_VALIDATION]
node0 7m 2.270s 2025-09-25 11:25:00.124 4165 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.502018Z ]
node0 7m 2.270s 2025-09-25 11:25:00.124 4166 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:24:58.502018Z,type=ENTER_VALIDATION]
node3 7m 2.358s 2025-09-25 11:25:00.212 4147 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.322851087Z ]
node3 7m 2.359s 2025-09-25 11:25:00.213 4148 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:24:58.322851087Z,type=ENTER_VALIDATION]
node3 7m 2.362s 2025-09-25 11:25:00.216 4149 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.502018Z ]
node3 7m 2.362s 2025-09-25 11:25:00.216 4150 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:24:58.502018Z,type=ENTER_VALIDATION]
node2 7m 2.544s 2025-09-25 11:25:00.398 4163 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.322851087Z ]
node2 7m 2.545s 2025-09-25 11:25:00.399 4164 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:24:58.322851087Z,type=ENTER_VALIDATION]
node2 7m 2.548s 2025-09-25 11:25:00.402 4165 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.502018Z ]
node2 7m 2.548s 2025-09-25 11:25:00.402 4166 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:24:58.502018Z,type=ENTER_VALIDATION]
node1 7m 3.097s 2025-09-25 11:25:00.951 4167 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.993262501Z ]
node1 7m 3.098s 2025-09-25 11:25:00.952 4168 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:24:58.993262501Z,type=ENTER_VALIDATION]
node2 7m 3.106s 2025-09-25 11:25:00.960 4167 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.993262501Z ]
node2 7m 3.107s 2025-09-25 11:25:00.961 4168 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:24:58.993262501Z,type=ENTER_VALIDATION]
node0 7m 3.114s 2025-09-25 11:25:00.968 4167 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.993262501Z ]
node0 7m 3.115s 2025-09-25 11:25:00.969 4168 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:24:58.993262501Z,type=ENTER_VALIDATION]
node3 7m 3.185s 2025-09-25 11:25:01.039 4167 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:24:58.993262501Z ]
node3 7m 3.186s 2025-09-25 11:25:01.040 4168 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:24:58.993262501Z,type=ENTER_VALIDATION]
node1 7m 3.658s 2025-09-25 11:25:01.512 4169 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:25:00.103499865Z ]
node1 7m 3.659s 2025-09-25 11:25:01.513 4170 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:00.103499865Z,type=ENTER_VALIDATION]
node1 7m 3.660s 2025-09-25 11:25:01.514 4171 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node1 7m 3.665s 2025-09-25 11:25:01.519 4176 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node1 7m 3.666s 2025-09-25 11:25:01.520 4177 INFO DEMO_INFO <<PTT: enter-validator 1>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node1 7m 3.666s 2025-09-25 11:25:01.520 4178 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1758799500103_103499865.json.gz
node1 7m 3.672s 2025-09-25 11:25:01.526 4179 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node1 7m 3.672s 2025-09-25 11:25:01.526 4180 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:00.103499865Z ]
node0 7m 3.675s 2025-09-25 11:25:01.529 4169 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:25:00.103499865Z ]
node0 7m 3.676s 2025-09-25 11:25:01.530 4170 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:00.103499865Z,type=ENTER_VALIDATION]
node0 7m 3.677s 2025-09-25 11:25:01.531 4171 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node0 7m 3.682s 2025-09-25 11:25:01.536 4176 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node0 7m 3.683s 2025-09-25 11:25:01.537 4177 INFO DEMO_INFO <<PTT: enter-validator 0>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node0 7m 3.683s 2025-09-25 11:25:01.537 4178 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1758799500103_103499865.json.gz
node0 7m 3.689s 2025-09-25 11:25:01.543 4179 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node0 7m 3.689s 2025-09-25 11:25:01.543 4180 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:00.103499865Z ]
node3 7m 3.766s 2025-09-25 11:25:01.620 4169 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:25:00.103499865Z ]
node3 7m 3.767s 2025-09-25 11:25:01.621 4170 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:00.103499865Z,type=ENTER_VALIDATION]
node3 7m 3.768s 2025-09-25 11:25:01.622 4171 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node3 7m 3.772s 2025-09-25 11:25:01.626 4176 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node3 7m 3.773s 2025-09-25 11:25:01.627 4177 INFO DEMO_INFO <<PTT: enter-validator 3>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node3 7m 3.773s 2025-09-25 11:25:01.627 4178 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1758799500103_103499865.json.gz
node3 7m 3.778s 2025-09-25 11:25:01.632 4179 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node3 7m 3.778s 2025-09-25 11:25:01.632 4180 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:00.103499865Z ]
node2 7m 3.952s 2025-09-25 11:25:01.806 4169 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-25T11:25:00.103499865Z ]
node2 7m 3.952s 2025-09-25 11:25:01.806 4170 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:00.103499865Z,type=ENTER_VALIDATION]
node2 7m 3.953s 2025-09-25 11:25:01.807 4171 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node2 7m 3.958s 2025-09-25 11:25:01.812 4176 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node2 7m 3.959s 2025-09-25 11:25:01.813 4177 INFO DEMO_INFO <<PTT: enter-validator 2>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node2 7m 3.959s 2025-09-25 11:25:01.813 4178 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1758799500103_103499865.json.gz
node2 7m 3.964s 2025-09-25 11:25:01.818 4179 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1758799500103_103499865.json, consensusTime = 2025-09-25T11:25:00.103499865Z ]
node2 7m 3.964s 2025-09-25 11:25:01.818 4180 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:00.103499865Z ]
node1 7m 5.917s 2025-09-25 11:25:03.771 4197 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.044010Z ]
node1 7m 5.917s 2025-09-25 11:25:03.771 4198 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:25:02.044010Z,type=EXIT_VALIDATION]
node1 7m 5.920s 2025-09-25 11:25:03.774 4199 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.122125613Z ]
node1 7m 5.921s 2025-09-25 11:25:03.775 4200 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:02.122125613Z,type=EXIT_VALIDATION]
node1 7m 5.921s 2025-09-25 11:25:03.775 4201 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.233233214Z ]
node1 7m 5.921s 2025-09-25 11:25:03.775 4202 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:25:02.233233214Z,type=EXIT_VALIDATION]
node1 7m 5.921s 2025-09-25 11:25:03.775 4203 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.301338292Z ]
node1 7m 5.921s 2025-09-25 11:25:03.775 4204 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:25:02.301338292Z,type=EXIT_VALIDATION]
node1 7m 5.922s 2025-09-25 11:25:03.776 4205 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-09-25T11:25:02.301338292Z ]
node1 7m 5.922s 2025-09-25 11:25:03.776 4207 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:02.301338292Z ]
node1 7m 5.923s 2025-09-25 11:25:03.777 4209 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 5.925s 2025-09-25 11:25:03.779 4197 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.044010Z ]
node2 7m 5.925s 2025-09-25 11:25:03.779 4198 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:25:02.044010Z,type=EXIT_VALIDATION]
node2 7m 5.928s 2025-09-25 11:25:03.782 4199 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.122125613Z ]
node2 7m 5.929s 2025-09-25 11:25:03.783 4200 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:02.122125613Z,type=EXIT_VALIDATION]
node2 7m 5.929s 2025-09-25 11:25:03.783 4201 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.233233214Z ]
node2 7m 5.929s 2025-09-25 11:25:03.783 4202 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:25:02.233233214Z,type=EXIT_VALIDATION]
node2 7m 5.929s 2025-09-25 11:25:03.783 4203 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.301338292Z ]
node2 7m 5.929s 2025-09-25 11:25:03.783 4204 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:25:02.301338292Z,type=EXIT_VALIDATION]
node2 7m 5.929s 2025-09-25 11:25:03.783 4205 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-09-25T11:25:02.301338292Z ]
node2 7m 5.930s 2025-09-25 11:25:03.784 4208 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:02.301338292Z ]
node2 7m 5.930s 2025-09-25 11:25:03.784 4209 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Waiting for final state to save before terminating
node0 7m 5.934s 2025-09-25 11:25:03.788 4197 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.044010Z ]
node0 7m 5.934s 2025-09-25 11:25:03.788 4198 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:25:02.044010Z,type=EXIT_VALIDATION]
node0 7m 5.938s 2025-09-25 11:25:03.792 4199 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.122125613Z ]
node0 7m 5.938s 2025-09-25 11:25:03.792 4200 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:02.122125613Z,type=EXIT_VALIDATION]
node0 7m 5.938s 2025-09-25 11:25:03.792 4201 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.233233214Z ]
node0 7m 5.938s 2025-09-25 11:25:03.792 4202 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:25:02.233233214Z,type=EXIT_VALIDATION]
node0 7m 5.938s 2025-09-25 11:25:03.792 4203 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.301338292Z ]
node0 7m 5.938s 2025-09-25 11:25:03.792 4204 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:25:02.301338292Z,type=EXIT_VALIDATION]
node0 7m 5.939s 2025-09-25 11:25:03.793 4205 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-09-25T11:25:02.301338292Z ]
node0 7m 5.939s 2025-09-25 11:25:03.793 4207 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:02.301338292Z ]
node0 7m 5.941s 2025-09-25 11:25:03.795 4211 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 7m 5.941s 2025-09-25 11:25:03.795 4212 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 7m 5.941s 2025-09-25 11:25:03.795 4213 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Waiting for final state to save before terminating
node3 7m 6.005s 2025-09-25 11:25:03.859 4197 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.044010Z ]
node3 7m 6.006s 2025-09-25 11:25:03.860 4198 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-25T11:25:02.044010Z,type=EXIT_VALIDATION]
node3 7m 6.010s 2025-09-25 11:25:03.864 4199 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.122125613Z ]
node3 7m 6.010s 2025-09-25 11:25:03.864 4200 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-25T11:25:02.122125613Z,type=EXIT_VALIDATION]
node3 7m 6.010s 2025-09-25 11:25:03.864 4201 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.233233214Z ]
node3 7m 6.010s 2025-09-25 11:25:03.864 4202 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-25T11:25:02.233233214Z,type=EXIT_VALIDATION]
node3 7m 6.011s 2025-09-25 11:25:03.865 4203 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-25T11:25:02.301338292Z ]
node3 7m 6.011s 2025-09-25 11:25:03.865 4204 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-25T11:25:02.301338292Z,type=EXIT_VALIDATION]
node3 7m 6.011s 2025-09-25 11:25:03.865 4205 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-09-25T11:25:02.301338292Z ]
node3 7m 6.012s 2025-09-25 11:25:03.866 4207 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-25T11:25:02.301338292Z ]
node3 7m 6.012s 2025-09-25 11:25:03.866 4209 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 8.084s 2025-09-25 11:25:05.938 4228 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1758799563
node0 7m 8.326s 2025-09-25 11:25:06.180 4230 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1758799563
node1 7m 8.328s 2025-09-25 11:25:06.182 4228 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1758799563
node3 7m 8.360s 2025-09-25 11:25:06.214 4228 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1758799563
node3 8m 6.675s 2025-09-25 11:26:04.529 4829 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 695 consensusTimeStamp: 2025-09-25T11:26:03.183936Z
node3 8m 6.675s 2025-09-25 11:26:04.529 4830 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-25T11:26:03.183936Z
node3 8m 6.676s 2025-09-25 11:26:04.530 4833 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 695 created, will eventually be written to disk, for reason: FREEZE_STATE
node3 8m 6.676s 2025-09-25 11:26:04.530 4834 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node3 8m 6.677s 2025-09-25 11:26:04.531 4835 TRACE DEMO_INFO <platformForkJoinThread-6> PlatformTestingToolMain: ENTERING FREEZING!
node3 8m 6.677s 2025-09-25 11:26:04.531 4838 TRACE DEMO_INFO <platformForkJoinThread-6> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node3 8m 6.677s 2025-09-25 11:26:04.531 4839 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change FREEZING
node3 8m 6.678s 2025-09-25 11:26:04.532 4840 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 695 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node3 8m 6.679s 2025-09-25 11:26:04.533 4841 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 695 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/695
node3 8m 6.679s 2025-09-25 11:26:04.533 4842 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node3 8m 6.706s 2025-09-25 11:26:04.560 4856 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 6.746s 2025-09-25 11:26:04.600 4829 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 695 consensusTimeStamp: 2025-09-25T11:26:03.183936Z
node2 8m 6.746s 2025-09-25 11:26:04.600 4830 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-25T11:26:03.183936Z
node2 8m 6.747s 2025-09-25 11:26:04.601 4831 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node2 8m 6.747s 2025-09-25 11:26:04.601 4832 TRACE DEMO_INFO <platformForkJoinThread-2> PlatformTestingToolMain: ENTERING FREEZING!
node2 8m 6.747s 2025-09-25 11:26:04.601 4835 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 695 created, will eventually be written to disk, for reason: FREEZE_STATE
node2 8m 6.748s 2025-09-25 11:26:04.602 4836 TRACE DEMO_INFO <platformForkJoinThread-2> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node2 8m 6.748s 2025-09-25 11:26:04.602 4837 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change FREEZING
node2 8m 6.749s 2025-09-25 11:26:04.603 4840 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 695 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node2 8m 6.750s 2025-09-25 11:26:04.604 4841 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 695 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/695
node2 8m 6.750s 2025-09-25 11:26:04.604 4842 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node2 8m 6.791s 2025-09-25 11:26:04.645 4857 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node1 8m 6.817s 2025-09-25 11:26:04.671 4829 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 695 consensusTimeStamp: 2025-09-25T11:26:03.183936Z
node1 8m 6.818s 2025-09-25 11:26:04.672 4830 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-25T11:26:03.183936Z
node1 8m 6.819s 2025-09-25 11:26:04.673 4831 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node1 8m 6.820s 2025-09-25 11:26:04.674 4833 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: ENTERING FREEZING!
node1 8m 6.820s 2025-09-25 11:26:04.674 4835 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 695 created, will eventually be written to disk, for reason: FREEZE_STATE
node1 8m 6.820s 2025-09-25 11:26:04.674 4836 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node1 8m 6.821s 2025-09-25 11:26:04.675 4839 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZING
node1 8m 6.822s 2025-09-25 11:26:04.676 4840 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 695 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node1 8m 6.822s 2025-09-25 11:26:04.676 4841 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 695 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/695
node1 8m 6.823s 2025-09-25 11:26:04.677 4842 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node1 8m 6.848s 2025-09-25 11:26:04.702 4854 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 8m 6.884s 2025-09-25 11:26:04.738 4831 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 695 consensusTimeStamp: 2025-09-25T11:26:03.183936Z
node0 8m 6.885s 2025-09-25 11:26:04.739 4832 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-25T11:26:03.183936Z
node0 8m 6.886s 2025-09-25 11:26:04.740 4833 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node0 8m 6.886s 2025-09-25 11:26:04.740 4834 TRACE DEMO_INFO <platformForkJoinThread-5> PlatformTestingToolMain: ENTERING FREEZING!
node0 8m 6.886s 2025-09-25 11:26:04.740 4837 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 695 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 8m 6.886s 2025-09-25 11:26:04.740 4838 TRACE DEMO_INFO <platformForkJoinThread-5> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node0 8m 6.887s 2025-09-25 11:26:04.741 4839 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZING
node0 8m 6.888s 2025-09-25 11:26:04.742 4842 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 695 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node0 8m 6.889s 2025-09-25 11:26:04.743 4843 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 695 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/695
node0 8m 6.889s 2025-09-25 11:26:04.743 4844 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node0 8m 6.915s 2025-09-25 11:26:04.769 4858 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 9.099s 2025-09-25 11:26:06.953 4930 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node2 8m 9.101s 2025-09-25 11:26:06.955 4931 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 695 Timestamp: 2025-09-25T11:26:03.183936Z Next consensus number: 12109 Legacy running event hash: 2ef714579bd17c5c75303c54c2d52eee7340034a787098074c310375d7dc5dfe9060e2b0fd1782f35a09f0c837c14cad Legacy running event mnemonic: ten-memory-magnet-merit Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1328171119 Root hash: 44ccef894ae67f4cf4cb64eebf4312ecb14ba2c1850d6ea3c46082473b5e4dd27672a2ad4af94d75662912ca7934fc23 (root) PlatformTestingToolState / office-auction-fresh-trumpet 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 clump-ketchup-hen-risk 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 coil-dutch-capable-lawsuit 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 8m 9.112s 2025-09-25 11:26:06.966 4932 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/2/2025/09/25/2025-09-25T11+18+46.978056357Z_seq5_minr22_maxr60_orgn0.pces Last file: data/saved/preconsensus-events/2/2025/09/25/2025-09-25T11+19+50.097573675Z_seq11_minr112_maxr158_orgn0.pces
node2 8m 9.112s 2025-09-25 11:26:06.966 4933 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 668 First file to copy: data/saved/preconsensus-events/2/2025/09/25/2025-09-25T11+25+38.736965661Z_seq38_minr628_maxr688_orgn0.pces Last file to copy: data/saved/preconsensus-events/2/2025/09/25/2025-09-25T11+25+59.947891105Z_seq39_minr661_maxr724_orgn0.pces
node2 8m 9.112s 2025-09-25 11:26:06.966 4934 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node2 8m 9.113s 2025-09-25 11:26:06.967 4935 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node2 8m 9.113s 2025-09-25 11:26:06.967 4936 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 695 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/695 {"round":695,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/695/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 8m 9.114s 2025-09-25 11:26:06.968 4937 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-25T11:26:03.183936Z ]
node2 8m 9.115s 2025-09-25 11:26:06.969 4938 INFO PLATFORM_STATUS <platformForkJoinThread-6> DefaultStatusStateMachine: Platform spent 2.4 s in FREEZING. Now in FREEZE_COMPLETE
node2 8m 9.115s 2025-09-25 11:26:06.969 4939 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node2 8m 9.115s 2025-09-25 11:26:06.969 4940 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-25T11:26:03.183936Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 8m 9.472s 2025-09-25 11:26:07.326 4930 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node3 8m 9.477s 2025-09-25 11:26:07.331 4931 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 695 Timestamp: 2025-09-25T11:26:03.183936Z Next consensus number: 12109 Legacy running event hash: 2ef714579bd17c5c75303c54c2d52eee7340034a787098074c310375d7dc5dfe9060e2b0fd1782f35a09f0c837c14cad Legacy running event mnemonic: ten-memory-magnet-merit Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1328171119 Root hash: 44ccef894ae67f4cf4cb64eebf4312ecb14ba2c1850d6ea3c46082473b5e4dd27672a2ad4af94d75662912ca7934fc23 (root) PlatformTestingToolState / office-auction-fresh-trumpet 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 clump-ketchup-hen-risk 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 coil-dutch-capable-lawsuit 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 8m 9.490s 2025-09-25 11:26:07.344 4932 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/3/2025/09/25/2025-09-25T11+23+43.915440001Z_seq30_minr458_maxr505_orgn0.pces Last file: data/saved/preconsensus-events/3/2025/09/25/2025-09-25T11+23+06.813150931Z_seq27_minr401_maxr448_orgn0.pces
node3 8m 9.490s 2025-09-25 11:26:07.344 4933 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 668 First file to copy: data/saved/preconsensus-events/3/2025/09/25/2025-09-25T11+25+35.667574194Z_seq38_minr623_maxr681_orgn0.pces Last file to copy: data/saved/preconsensus-events/3/2025/09/25/2025-09-25T11+25+55.566824130Z_seq39_minr654_maxr715_orgn0.pces
node3 8m 9.491s 2025-09-25 11:26:07.345 4934 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node3 8m 9.491s 2025-09-25 11:26:07.345 4935 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node3 8m 9.492s 2025-09-25 11:26:07.346 4936 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 695 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/695 {"round":695,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/695/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 8m 9.494s 2025-09-25 11:26:07.348 4937 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-25T11:26:03.183936Z ]
node3 8m 9.494s 2025-09-25 11:26:07.348 4938 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.8 s in FREEZING. Now in FREEZE_COMPLETE
node3 8m 9.495s 2025-09-25 11:26:07.349 4939 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node3 8m 9.496s 2025-09-25 11:26:07.350 4940 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-25T11:26:03.183936Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 8m 9.661s 2025-09-25 11:26:07.515 4932 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node0 8m 9.663s 2025-09-25 11:26:07.517 4933 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 695 Timestamp: 2025-09-25T11:26:03.183936Z Next consensus number: 12109 Legacy running event hash: 2ef714579bd17c5c75303c54c2d52eee7340034a787098074c310375d7dc5dfe9060e2b0fd1782f35a09f0c837c14cad Legacy running event mnemonic: ten-memory-magnet-merit Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1328171119 Root hash: 44ccef894ae67f4cf4cb64eebf4312ecb14ba2c1850d6ea3c46082473b5e4dd27672a2ad4af94d75662912ca7934fc23 (root) PlatformTestingToolState / office-auction-fresh-trumpet 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 clump-ketchup-hen-risk 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 coil-dutch-capable-lawsuit 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 8m 9.675s 2025-09-25 11:26:07.529 4934 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 39 preconsensus files on disk.
First file: data/saved/preconsensus-events/0/2025/09/25/2025-09-25T11+24+46.786522943Z_seq35_minr551_maxr606_orgn0.pces Last file: data/saved/preconsensus-events/0/2025/09/25/2025-09-25T11+21+04.300903102Z_seq17_minr220_maxr265_orgn0.pces
node0 8m 9.675s 2025-09-25 11:26:07.529 4935 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 668 First file to copy: data/saved/preconsensus-events/0/2025/09/25/2025-09-25T11+25+26.795360296Z_seq37_minr609_maxr669_orgn0.pces Last file to copy: data/saved/preconsensus-events/0/2025/09/25/2025-09-25T11+25+47.955689057Z_seq38_minr642_maxr704_orgn0.pces
node0 8m 9.676s 2025-09-25 11:26:07.530 4936 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node0 8m 9.677s 2025-09-25 11:26:07.531 4937 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node0 8m 9.677s 2025-09-25 11:26:07.531 4938 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 695 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/695 {"round":695,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/695/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 8m 9.678s 2025-09-25 11:26:07.532 4939 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-25T11:26:03.183936Z ]
node0 8m 9.679s 2025-09-25 11:26:07.533 4940 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 2.8 s in FREEZING. Now in FREEZE_COMPLETE
node0 8m 9.679s 2025-09-25 11:26:07.533 4941 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 8m 9.679s 2025-09-25 11:26:07.533 4942 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-25T11:26:03.183936Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 8m 10.431s 2025-09-25 11:26:08.285 4930 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/9 for round 695
node1 8m 10.434s 2025-09-25 11:26:08.288 4931 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 695 Timestamp: 2025-09-25T11:26:03.183936Z Next consensus number: 12109 Legacy running event hash: 2ef714579bd17c5c75303c54c2d52eee7340034a787098074c310375d7dc5dfe9060e2b0fd1782f35a09f0c837c14cad Legacy running event mnemonic: ten-memory-magnet-merit Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1328171119 Root hash: 44ccef894ae67f4cf4cb64eebf4312ecb14ba2c1850d6ea3c46082473b5e4dd27672a2ad4af94d75662912ca7934fc23 (root) PlatformTestingToolState / office-auction-fresh-trumpet 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 clump-ketchup-hen-risk 1 VirtualMap RosterService.ROSTERS /1 million-when-dilemma-door 2 SingletonNode RosterService.ROSTER_STATE /2 trim-tent-right-poverty 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 verb-arrange-angry-absurd 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 coil-dutch-capable-lawsuit 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 8m 10.447s 2025-09-25 11:26:08.301 4932 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/1/2025/09/25/2025-09-25T11+24+34.190895031Z_seq34_minr534_maxr579_orgn0.pces Last file: data/saved/preconsensus-events/1/2025/09/25/2025-09-25T11+20+14.539030346Z_seq13_minr147_maxr193_orgn0.pces
node1 8m 10.447s 2025-09-25 11:26:08.301 4933 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 668 First file to copy: data/saved/preconsensus-events/1/2025/09/25/2025-09-25T11+25+39.548336322Z_seq38_minr629_maxr689_orgn0.pces Last file to copy: data/saved/preconsensus-events/1/2025/09/25/2025-09-25T11+26+00.568254815Z_seq39_minr662_maxr725_orgn0.pces
node1 8m 10.447s 2025-09-25 11:26:08.301 4934 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node1 8m 10.448s 2025-09-25 11:26:08.302 4935 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node1 8m 10.448s 2025-09-25 11:26:08.302 4936 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 695 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/695 {"round":695,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/695/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node1 8m 10.449s 2025-09-25 11:26:08.303 4937 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-25T11:26:03.183936Z ]
node1 8m 10.450s 2025-09-25 11:26:08.304 4938 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 3.6 s in FREEZING. Now in FREEZE_COMPLETE
node1 8m 10.451s 2025-09-25 11:26:08.305 4939 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-25T11:26:03.183936Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 8m 10.451s 2025-09-25 11:26:08.305 4940 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE