Node ID






Columns











Log Level






Log Marker











Class















































node1 0.000ns 2025-09-29 10:18:57.222 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 87.000ms 2025-09-29 10:18:57.309 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 215.000ms 2025-09-29 10:18:57.437 3 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node1 222.000ms 2025-09-29 10:18:57.444 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 228.000ms 2025-09-29 10:18:57.450 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 253.000ms 2025-09-29 10:18:57.475 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 255.000ms 2025-09-29 10:18:57.477 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 255.000ms 2025-09-29 10:18:57.477 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 256.000ms 2025-09-29 10:18:57.478 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 256.000ms 2025-09-29 10:18:57.478 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 257.000ms 2025-09-29 10:18:57.479 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 257.000ms 2025-09-29 10:18:57.479 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 258.000ms 2025-09-29 10:18:57.480 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 259.000ms 2025-09-29 10:18:57.481 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 259.000ms 2025-09-29 10:18:57.481 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 259.000ms 2025-09-29 10:18:57.481 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 260.000ms 2025-09-29 10:18:57.482 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 260.000ms 2025-09-29 10:18:57.482 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 260.000ms 2025-09-29 10:18:57.482 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 261.000ms 2025-09-29 10:18:57.483 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 320.000ms 2025-09-29 10:18:57.542 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 454.000ms 2025-09-29 10:18:57.676 3 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 461.000ms 2025-09-29 10:18:57.683 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node2 489.000ms 2025-09-29 10:18:57.711 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 490.000ms 2025-09-29 10:18:57.712 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 491.000ms 2025-09-29 10:18:57.713 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 491.000ms 2025-09-29 10:18:57.713 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 492.000ms 2025-09-29 10:18:57.714 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 493.000ms 2025-09-29 10:18:57.715 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 493.000ms 2025-09-29 10:18:57.715 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 494.000ms 2025-09-29 10:18:57.716 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 494.000ms 2025-09-29 10:18:57.716 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 495.000ms 2025-09-29 10:18:57.717 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 495.000ms 2025-09-29 10:18:57.717 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 496.000ms 2025-09-29 10:18:57.718 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 496.000ms 2025-09-29 10:18:57.718 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 496.000ms 2025-09-29 10:18:57.718 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 497.000ms 2025-09-29 10:18:57.719 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 667.000ms 2025-09-29 10:18:57.889 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 920.000ms 2025-09-29 10:18:58.142 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 1.484s 2025-09-29 10:18:58.706 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 1.533s 2025-09-29 10:18:58.755 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 866ms
node1 1.582s 2025-09-29 10:18:58.804 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 1.583s 2025-09-29 10:18:58.805 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 1.641s 2025-09-29 10:18:58.863 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 1.642s 2025-09-29 10:18:58.864 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 1.732s 2025-09-29 10:18:58.954 3 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 1.740s 2025-09-29 10:18:58.962 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 1.771s 2025-09-29 10:18:58.993 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.773s 2025-09-29 10:18:58.995 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.774s 2025-09-29 10:18:58.996 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.775s 2025-09-29 10:18:58.997 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.775s 2025-09-29 10:18:58.997 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.775s 2025-09-29 10:18:58.997 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.776s 2025-09-29 10:18:58.998 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.777s 2025-09-29 10:18:58.999 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.777s 2025-09-29 10:18:58.999 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.778s 2025-09-29 10:18:59.000 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.778s 2025-09-29 10:18:59.000 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.778s 2025-09-29 10:18:59.000 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.779s 2025-09-29 10:18:59.001 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.779s 2025-09-29 10:18:59.001 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.780s 2025-09-29 10:18:59.002 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 1.941s 2025-09-29 10:18:59.163 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1021ms
node2 1.988s 2025-09-29 10:18:59.210 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node2 2.052s 2025-09-29 10:18:59.274 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 2.053s 2025-09-29 10:18:59.275 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 2.219s 2025-09-29 10:18:59.441 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 3.149s 2025-09-29 10:19:00.371 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 929ms
node3 3.193s 2025-09-29 10:19:00.415 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 3.268s 2025-09-29 10:19:00.490 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 3.269s 2025-09-29 10:19:00.491 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 3.655s 2025-09-29 10:19:00.877 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 3.699s 2025-09-29 10:19:00.921 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 3.745s 2025-09-29 10:19:00.967 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 3.746s 2025-09-29 10:19:00.968 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 3.746s 2025-09-29 10:19:00.968 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 3.746s 2025-09-29 10:19:00.968 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 3.747s 2025-09-29 10:19:00.969 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 3.747s 2025-09-29 10:19:00.969 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 3.747s 2025-09-29 10:19:00.969 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 3.748s 2025-09-29 10:19:00.970 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 3.751s 2025-09-29 10:19:00.973 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 3.754s 2025-09-29 10:19:00.976 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 3.755s 2025-09-29 10:19:00.977 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node0 3.800s 2025-09-29 10:19:01.022 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 3.952s 2025-09-29 10:19:01.174 3 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 3.960s 2025-09-29 10:19:01.182 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 3.993s 2025-09-29 10:19:01.215 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 3.995s 2025-09-29 10:19:01.217 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 3.996s 2025-09-29 10:19:01.218 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 3.997s 2025-09-29 10:19:01.219 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 3.998s 2025-09-29 10:19:01.220 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 3.998s 2025-09-29 10:19:01.220 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 3.999s 2025-09-29 10:19:01.221 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 4.000s 2025-09-29 10:19:01.222 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 4.001s 2025-09-29 10:19:01.223 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 4.001s 2025-09-29 10:19:01.223 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 4.002s 2025-09-29 10:19:01.224 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 4.002s 2025-09-29 10:19:01.224 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 4.002s 2025-09-29 10:19:01.224 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 4.003s 2025-09-29 10:19:01.225 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 4.003s 2025-09-29 10:19:01.225 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 4.149s 2025-09-29 10:19:01.371 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 4.233s 2025-09-29 10:19:01.455 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 4.234s 2025-09-29 10:19:01.456 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 4.234s 2025-09-29 10:19:01.456 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 4.234s 2025-09-29 10:19:01.456 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 4.235s 2025-09-29 10:19:01.457 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 4.235s 2025-09-29 10:19:01.457 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 4.236s 2025-09-29 10:19:01.458 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 4.236s 2025-09-29 10:19:01.458 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 4.239s 2025-09-29 10:19:01.461 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.242s 2025-09-29 10:19:01.464 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 4.243s 2025-09-29 10:19:01.465 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node1 4.449s 2025-09-29 10:19:01.671 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 4.450s 2025-09-29 10:19:01.672 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 4.452s 2025-09-29 10:19:01.674 42 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node1 4.501s 2025-09-29 10:19:01.723 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node1 4.506s 2025-09-29 10:19:01.728 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 4.506s 2025-09-29 10:19:01.728 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 4.507s 2025-09-29 10:19:01.729 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node1 4.549s 2025-09-29 10:19:01.771 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 4.554s 2025-09-29 10:19:01.776 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 4.970s 2025-09-29 10:19:02.192 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 4.971s 2025-09-29 10:19:02.193 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.025s 2025-09-29 10:19:02.247 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node2 5.031s 2025-09-29 10:19:02.253 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 5.032s 2025-09-29 10:19:02.254 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 5.032s 2025-09-29 10:19:02.254 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node2 5.083s 2025-09-29 10:19:02.305 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 5.090s 2025-09-29 10:19:02.312 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node3 5.344s 2025-09-29 10:19:02.566 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 5.424s 2025-09-29 10:19:02.646 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 5.425s 2025-09-29 10:19:02.647 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 5.425s 2025-09-29 10:19:02.647 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 5.426s 2025-09-29 10:19:02.648 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 5.426s 2025-09-29 10:19:02.648 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 5.426s 2025-09-29 10:19:02.648 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 5.426s 2025-09-29 10:19:02.648 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 5.427s 2025-09-29 10:19:02.649 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 5.429s 2025-09-29 10:19:02.651 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 5.433s 2025-09-29 10:19:02.655 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 5.433s 2025-09-29 10:19:02.655 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node1 5.681s 2025-09-29 10:19:02.903 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20972948] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=107770, randomLong=-3420171089146381022, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9640, randomLong=4215028902291985786, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1002130, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms)
node0 5.692s 2025-09-29 10:19:02.914 43 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1240ms
node1 5.709s 2025-09-29 10:19:02.931 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 5.718s 2025-09-29 10:19:02.940 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 5.724s 2025-09-29 10:19:02.946 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 5.741s 2025-09-29 10:19:02.963 44 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 5.815s 2025-09-29 10:19:03.037 45 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 5.816s 2025-09-29 10:19:03.038 46 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 5.818s 2025-09-29 10:19:03.040 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IinjsA==", "port": 30124 }, { "ipAddressV4": "CoAAeg==", "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": "iHB1MQ==", "port": 30125 }, { "ipAddressV4": "CoAAfQ==", "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": "IjkvUg==", "port": 30126 }, { "ipAddressV4": "CoAAew==", "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": "iHIW1w==", "port": 30127 }, { "ipAddressV4": "CoAAfA==", "port": 30127 }] }] }
node1 5.914s 2025-09-29 10:19:03.136 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 5.915s 2025-09-29 10:19:03.137 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 5.917s 2025-09-29 10:19:03.139 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.917s 2025-09-29 10:19:03.139 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node1 5.918s 2025-09-29 10:19:03.140 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node1 5.921s 2025-09-29 10:19:03.143 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.921s 2025-09-29 10:19:03.143 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 5.921s 2025-09-29 10:19:03.143 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node1 5.923s 2025-09-29 10:19:03.145 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node1 5.923s 2025-09-29 10:19:03.145 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 5.923s 2025-09-29 10:19:03.145 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node1 5.937s 2025-09-29 10:19:03.159 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 17f604de4e032e65c753e8a8e55a2fe5858e1a6c2263f06757cd74bcd95b26e23751bba79a78f0a7b5470dec0269a5bf First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / yard-orange-scatter-smile 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 6.140s 2025-09-29 10:19:03.362 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.141s 2025-09-29 10:19:03.363 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node1 6.142s 2025-09-29 10:19:03.364 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node1 6.147s 2025-09-29 10:19:03.369 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node1 6.155s 2025-09-29 10:19:03.377 138 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 6.156s 2025-09-29 10:19:03.378 139 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 6.158s 2025-09-29 10:19:03.380 140 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 6.158s 2025-09-29 10:19:03.380 141 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 6.159s 2025-09-29 10:19:03.381 142 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 6.159s 2025-09-29 10:19:03.381 143 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 6.159s 2025-09-29 10:19:03.381 144 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 6.159s 2025-09-29 10:19:03.381 145 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 6.159s 2025-09-29 10:19:03.381 146 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 6.160s 2025-09-29 10:19:03.382 147 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 6.160s 2025-09-29 10:19:03.382 148 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 6.160s 2025-09-29 10:19:03.382 149 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 6.160s 2025-09-29 10:19:03.382 150 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 6.160s 2025-09-29 10:19:03.382 151 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 6.161s 2025-09-29 10:19:03.383 152 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node1 6.175s 2025-09-29 10:19:03.397 153 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 6.176s 2025-09-29 10:19:03.398 154 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 6.176s 2025-09-29 10:19:03.398 155 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 6.176s 2025-09-29 10:19:03.398 156 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 6.177s 2025-09-29 10:19:03.399 157 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 6.177s 2025-09-29 10:19:03.399 158 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node1 6.177s 2025-09-29 10:19:03.399 159 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 6.179s 2025-09-29 10:19:03.401 160 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node1 6.184s 2025-09-29 10:19:03.406 161 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@ab36eb4
node1 6.184s 2025-09-29 10:19:03.406 162 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 80000
node1 6.185s 2025-09-29 10:19:03.407 163 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node1 6.191s 2025-09-29 10:19:03.413 168 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@5b590e5d, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2694b3e6,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@400857b7,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@37c82dbd,snapshotInProgress=false]
node1 6.199s 2025-09-29 10:19:03.421 169 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 6.200s 2025-09-29 10:19:03.422 170 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node3 6.202s 2025-09-29 10:19:03.424 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node1 6.204s 2025-09-29 10:19:03.426 171 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is 908685986774482641
node1 6.204s 2025-09-29 10:19:03.426 172 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 6.209s 2025-09-29 10:19:03.431 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 6.209s 2025-09-29 10:19:03.431 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 6.209s 2025-09-29 10:19:03.431 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node2 6.231s 2025-09-29 10:19:03.453 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20920681] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=305660, randomLong=4612084491356269371, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=17330, randomLong=-2795600095992803120, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=970130, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms)
node3 6.260s 2025-09-29 10:19:03.482 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node2 6.262s 2025-09-29 10:19:03.484 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 6.266s 2025-09-29 10:19:03.488 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 6.270s 2025-09-29 10:19:03.492 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 6.276s 2025-09-29 10:19:03.498 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node1 6.281s 2025-09-29 10:19:03.503 173 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 6.282s 2025-09-29 10:19:03.504 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 6.286s 2025-09-29 10:19:03.508 175 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 6.287s 2025-09-29 10:19:03.509 176 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 6.288s 2025-09-29 10:19:03.510 177 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 6.289s 2025-09-29 10:19:03.511 178 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 6.290s 2025-09-29 10:19:03.512 179 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 6.291s 2025-09-29 10:19:03.513 180 INFO STARTUP <<start-node-1>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node1 6.292s 2025-09-29 10:19:03.514 181 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 302.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 6.292s 2025-09-29 10:19:03.514 182 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node1 6.296s 2025-09-29 10:19:03.518 183 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 6.297s 2025-09-29 10:19:03.519 184 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 6.298s 2025-09-29 10:19:03.520 185 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 6.363s 2025-09-29 10:19:03.585 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IinjsA==", "port": 30124 }, { "ipAddressV4": "CoAAeg==", "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": "iHB1MQ==", "port": 30125 }, { "ipAddressV4": "CoAAfQ==", "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": "IjkvUg==", "port": 30126 }, { "ipAddressV4": "CoAAew==", "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": "iHIW1w==", "port": 30127 }, { "ipAddressV4": "CoAAfA==", "port": 30127 }] }] }
node2 6.468s 2025-09-29 10:19:03.690 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 6.469s 2025-09-29 10:19:03.691 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node2 6.471s 2025-09-29 10:19:03.693 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.471s 2025-09-29 10:19:03.693 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node2 6.472s 2025-09-29 10:19:03.694 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node2 6.476s 2025-09-29 10:19:03.698 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.476s 2025-09-29 10:19:03.698 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.476s 2025-09-29 10:19:03.698 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node2 6.478s 2025-09-29 10:19:03.700 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node2 6.478s 2025-09-29 10:19:03.700 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node2 6.479s 2025-09-29 10:19:03.701 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node2 6.494s 2025-09-29 10:19:03.716 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 17f604de4e032e65c753e8a8e55a2fe5858e1a6c2263f06757cd74bcd95b26e23751bba79a78f0a7b5470dec0269a5bf First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / yard-orange-scatter-smile 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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.700s 2025-09-29 10:19:03.922 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 6.704s 2025-09-29 10:19:03.926 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 6.714s 2025-09-29 10:19:03.936 138 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 6.714s 2025-09-29 10:19:03.936 139 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 6.717s 2025-09-29 10:19:03.939 140 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 6.718s 2025-09-29 10:19:03.940 141 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 6.718s 2025-09-29 10:19:03.940 142 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 6.718s 2025-09-29 10:19:03.940 143 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 6.718s 2025-09-29 10:19:03.940 144 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 6.718s 2025-09-29 10:19:03.940 145 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 6.719s 2025-09-29 10:19:03.941 146 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 6.719s 2025-09-29 10:19:03.941 147 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 6.719s 2025-09-29 10:19:03.941 148 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 6.719s 2025-09-29 10:19:03.941 149 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 6.719s 2025-09-29 10:19:03.941 150 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 6.720s 2025-09-29 10:19:03.942 151 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 6.720s 2025-09-29 10:19:03.942 152 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node2 6.736s 2025-09-29 10:19:03.958 153 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 6.737s 2025-09-29 10:19:03.959 154 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 6.738s 2025-09-29 10:19:03.960 155 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 6.738s 2025-09-29 10:19:03.960 156 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 6.738s 2025-09-29 10:19:03.960 157 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 6.739s 2025-09-29 10:19:03.961 158 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node2 6.739s 2025-09-29 10:19:03.961 159 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 6.741s 2025-09-29 10:19:03.963 160 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node2 6.746s 2025-09-29 10:19:03.968 161 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@45933d6a
node2 6.748s 2025-09-29 10:19:03.970 162 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 80000
node2 6.748s 2025-09-29 10:19:03.970 163 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node2 6.755s 2025-09-29 10:19:03.977 168 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@e5f2a0b, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@221ba04b,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@2edefab5,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@21e92b18,snapshotInProgress=false]
node2 6.764s 2025-09-29 10:19:03.986 169 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 6.764s 2025-09-29 10:19:03.986 170 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 6.769s 2025-09-29 10:19:03.991 171 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is 140587398643674091
node2 6.770s 2025-09-29 10:19:03.992 172 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node2 6.871s 2025-09-29 10:19:04.093 173 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node2 6.875s 2025-09-29 10:19:04.097 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 6.880s 2025-09-29 10:19:04.102 175 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 6.882s 2025-09-29 10:19:04.104 176 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 6.882s 2025-09-29 10:19:04.104 177 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 6.884s 2025-09-29 10:19:04.106 178 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node2 6.884s 2025-09-29 10:19:04.106 179 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 6.887s 2025-09-29 10:19:04.109 180 INFO STARTUP <<start-node-2>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node2 6.888s 2025-09-29 10:19:04.110 181 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 6.890s 2025-09-29 10:19:04.112 182 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 340.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 6.895s 2025-09-29 10:19:04.117 183 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 6.896s 2025-09-29 10:19:04.118 184 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 6.896s 2025-09-29 10:19:04.118 185 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change OBSERVING
node3 7.388s 2025-09-29 10:19:04.610 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=20809096] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=239250, randomLong=5315877498507275780, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=24440, randomLong=-2521726178691302404, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1501141, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms)
node3 7.427s 2025-09-29 10:19:04.649 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 7.436s 2025-09-29 10:19:04.658 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 7.442s 2025-09-29 10:19:04.664 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node3 7.544s 2025-09-29 10:19:04.766 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IinjsA==", "port": 30124 }, { "ipAddressV4": "CoAAeg==", "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": "iHB1MQ==", "port": 30125 }, { "ipAddressV4": "CoAAfQ==", "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": "IjkvUg==", "port": 30126 }, { "ipAddressV4": "CoAAew==", "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": "iHIW1w==", "port": 30127 }, { "ipAddressV4": "CoAAfA==", "port": 30127 }] }] }
node3 7.661s 2025-09-29 10:19:04.883 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 7.661s 2025-09-29 10:19:04.883 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 7.664s 2025-09-29 10:19:04.886 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.664s 2025-09-29 10:19:04.886 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node3 7.664s 2025-09-29 10:19:04.886 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node3 7.669s 2025-09-29 10:19:04.891 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.669s 2025-09-29 10:19:04.891 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 7.669s 2025-09-29 10:19:04.891 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node3 7.671s 2025-09-29 10:19:04.893 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node3 7.671s 2025-09-29 10:19:04.893 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node3 7.672s 2025-09-29 10:19:04.894 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node3 7.687s 2025-09-29 10:19:04.909 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 17f604de4e032e65c753e8a8e55a2fe5858e1a6c2263f06757cd74bcd95b26e23751bba79a78f0a7b5470dec0269a5bf First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / yard-orange-scatter-smile 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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.883s 2025-09-29 10:19:05.105 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 7.887s 2025-09-29 10:19:05.109 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 7.897s 2025-09-29 10:19:05.119 138 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 7.898s 2025-09-29 10:19:05.120 139 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 7.901s 2025-09-29 10:19:05.123 140 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 7.902s 2025-09-29 10:19:05.124 141 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 7.902s 2025-09-29 10:19:05.124 142 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 7.902s 2025-09-29 10:19:05.124 143 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 7.902s 2025-09-29 10:19:05.124 144 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 7.903s 2025-09-29 10:19:05.125 145 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 7.903s 2025-09-29 10:19:05.125 146 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 7.903s 2025-09-29 10:19:05.125 147 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 7.903s 2025-09-29 10:19:05.125 148 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 7.903s 2025-09-29 10:19:05.125 149 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 7.904s 2025-09-29 10:19:05.126 150 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 7.904s 2025-09-29 10:19:05.126 151 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 7.904s 2025-09-29 10:19:05.126 152 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 7.912s 2025-09-29 10:19:05.134 47 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 7.921s 2025-09-29 10:19:05.143 153 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 7.922s 2025-09-29 10:19:05.144 154 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 7.922s 2025-09-29 10:19:05.144 155 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 7.923s 2025-09-29 10:19:05.145 156 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 7.923s 2025-09-29 10:19:05.145 157 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 7.923s 2025-09-29 10:19:05.145 158 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node3 7.924s 2025-09-29 10:19:05.146 159 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 7.925s 2025-09-29 10:19:05.147 160 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node3 7.931s 2025-09-29 10:19:05.153 161 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@53450486
node3 7.932s 2025-09-29 10:19:05.154 162 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 80000
node3 7.932s 2025-09-29 10:19:05.154 163 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node3 7.939s 2025-09-29 10:19:05.161 168 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@3a7d07a4, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@437b75de,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@6240e184,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@184b2256,snapshotInProgress=false]
node3 7.948s 2025-09-29 10:19:05.170 169 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 7.948s 2025-09-29 10:19:05.170 170 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 7.952s 2025-09-29 10:19:05.174 171 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is 1504176310772239678
node3 7.952s 2025-09-29 10:19:05.174 172 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 8.014s 2025-09-29 10:19:05.236 50 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 8.015s 2025-09-29 10:19:05.237 51 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 8.015s 2025-09-29 10:19:05.237 52 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 8.016s 2025-09-29 10:19:05.238 53 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 8.016s 2025-09-29 10:19:05.238 54 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 8.016s 2025-09-29 10:19:05.238 55 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 8.017s 2025-09-29 10:19:05.239 56 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 8.017s 2025-09-29 10:19:05.239 57 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 8.020s 2025-09-29 10:19:05.242 65 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 8.024s 2025-09-29 10:19:05.246 66 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 8.024s 2025-09-29 10:19:05.246 67 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: PlatformStateService / Number of children: 0 / node: com.swirlds.state.merkle.singleton.SingletonNode@60acd609
node3 8.034s 2025-09-29 10:19:05.256 173 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 8.036s 2025-09-29 10:19:05.258 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 8.040s 2025-09-29 10:19:05.262 175 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 8.041s 2025-09-29 10:19:05.263 176 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 8.041s 2025-09-29 10:19:05.263 177 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 8.043s 2025-09-29 10:19:05.265 178 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 8.043s 2025-09-29 10:19:05.265 179 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 8.045s 2025-09-29 10:19:05.267 180 INFO STARTUP <<start-node-3>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node3 8.046s 2025-09-29 10:19:05.268 181 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 304.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 8.046s 2025-09-29 10:19:05.268 182 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 8.049s 2025-09-29 10:19:05.271 183 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 8.050s 2025-09-29 10:19:05.272 184 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 8.050s 2025-09-29 10:19:05.272 185 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 8.788s 2025-09-29 10:19:06.010 75 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 8.789s 2025-09-29 10:19:06.011 76 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 8.849s 2025-09-29 10:19:06.071 82 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 1 / node: com.swirlds.virtualmap.VirtualMap@433d9680
node0 8.855s 2025-09-29 10:19:06.077 90 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 8.855s 2025-09-29 10:19:06.077 91 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 8.856s 2025-09-29 10:19:06.078 92 INFO STARTUP <main> MerkleStateRoot: Setting child.. Service name: RosterService / Number of children: 2 / node: com.swirlds.state.merkle.singleton.SingletonNode@2da81754
node0 8.905s 2025-09-29 10:19:06.127 95 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 8.912s 2025-09-29 10:19:06.134 96 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 9.163s 2025-09-29 10:19:06.385 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting1.csv' ]
node1 9.165s 2025-09-29 10:19:06.387 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node2 9.722s 2025-09-29 10:19:06.944 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 9.724s 2025-09-29 10:19:06.946 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 10.045s 2025-09-29 10:19:07.267 97 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26301796] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=402790, randomLong=-8144594309650291780, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13560, randomLong=-23554665789718764, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1444490, data=35, exception=null] OS Health Check Report - Complete (took 1024 ms)
node0 10.077s 2025-09-29 10:19:07.299 98 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 10.085s 2025-09-29 10:19:07.307 99 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 10.091s 2025-09-29 10:19:07.313 100 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 10.180s 2025-09-29 10:19:07.402 101 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "2685636917", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "IinjsA==", "port": 30124 }, { "ipAddressV4": "CoAAeg==", "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": "iHB1MQ==", "port": 30125 }, { "ipAddressV4": "CoAAfQ==", "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": "IjkvUg==", "port": 30126 }, { "ipAddressV4": "CoAAew==", "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": "iHIW1w==", "port": 30127 }, { "ipAddressV4": "CoAAfA==", "port": 30127 }] }] }
node0 10.289s 2025-09-29 10:19:07.511 102 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 10.289s 2025-09-29 10:19:07.511 103 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 10.292s 2025-09-29 10:19:07.514 111 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 10.293s 2025-09-29 10:19:07.515 112 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: PlatformStateService
node0 10.293s 2025-09-29 10:19:07.515 113 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: PlatformStateService / Number of children: 13 / node: 0
node0 10.296s 2025-09-29 10:19:07.518 121 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 10.297s 2025-09-29 10:19:07.519 122 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 10.297s 2025-09-29 10:19:07.519 123 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 1
node0 10.299s 2025-09-29 10:19:07.521 131 INFO STARTUP <main> MerkleStateRoot: Putting states...
node0 10.299s 2025-09-29 10:19:07.521 132 INFO STARTUP <main> MerkleStateRoot: Put states! Service name: RosterService
node0 10.299s 2025-09-29 10:19:07.521 133 INFO STARTUP <main> MerkleStateRoot: Getting child.. Service name: RosterService / Number of children: 13 / node: 2
node0 10.315s 2025-09-29 10:19:07.537 134 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 17f604de4e032e65c753e8a8e55a2fe5858e1a6c2263f06757cd74bcd95b26e23751bba79a78f0a7b5470dec0269a5bf First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / yard-orange-scatter-smile 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 dwarf-staff-copper-this 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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 10.555s 2025-09-29 10:19:07.777 136 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 10.561s 2025-09-29 10:19:07.783 137 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 10.581s 2025-09-29 10:19:07.803 138 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 10.583s 2025-09-29 10:19:07.805 139 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 10.586s 2025-09-29 10:19:07.808 140 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 10.587s 2025-09-29 10:19:07.809 141 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 10.587s 2025-09-29 10:19:07.809 142 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 10.587s 2025-09-29 10:19:07.809 143 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 10.588s 2025-09-29 10:19:07.810 144 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 10.588s 2025-09-29 10:19:07.810 145 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 10.588s 2025-09-29 10:19:07.810 146 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 10.588s 2025-09-29 10:19:07.810 147 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 10.588s 2025-09-29 10:19:07.810 148 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 10.588s 2025-09-29 10:19:07.810 149 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 10.589s 2025-09-29 10:19:07.811 150 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 10.589s 2025-09-29 10:19:07.811 151 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 10.589s 2025-09-29 10:19:07.811 152 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON VMerkle-Hotspot-1k-15m.json
node0 10.609s 2025-09-29 10:19:07.831 153 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 10.610s 2025-09-29 10:19:07.832 154 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 10.611s 2025-09-29 10:19:07.833 155 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 10.611s 2025-09-29 10:19:07.833 156 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 10.612s 2025-09-29 10:19:07.834 157 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 10.612s 2025-09-29 10:19:07.834 158 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_VIRTUAL_MERKLE_TEST
node0 10.612s 2025-09-29 10:19:07.834 159 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 10.614s 2025-09-29 10:19:07.836 160 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 1000.0
node0 10.622s 2025-09-29 10:19:07.844 161 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@2affc5c9
node0 10.623s 2025-09-29 10:19:07.845 162 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 80000
node0 10.623s 2025-09-29 10:19:07.845 163 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 80000 accounts.
node0 10.633s 2025-09-29 10:19:07.855 168 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@39eb4f0a, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@45495dcc,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@7e2392d7,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4277d45a,snapshotInProgress=false]
node0 10.642s 2025-09-29 10:19:07.864 169 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 10.643s 2025-09-29 10:19:07.865 170 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 10.648s 2025-09-29 10:19:07.870 171 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is 6251498313488496822
node0 10.649s 2025-09-29 10:19:07.871 172 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 10.736s 2025-09-29 10:19:07.958 173 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 10.737s 2025-09-29 10:19:07.959 174 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 10.742s 2025-09-29 10:19:07.964 175 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 10.743s 2025-09-29 10:19:07.965 176 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 10.744s 2025-09-29 10:19:07.966 177 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 10.745s 2025-09-29 10:19:07.967 178 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 10.746s 2025-09-29 10:19:07.968 179 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 10.748s 2025-09-29 10:19:07.970 180 INFO STARTUP <<start-node-0>> PcesReplayer: Replayed 0 preconsensus events. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node0 10.749s 2025-09-29 10:19:07.971 181 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 375.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 10.749s 2025-09-29 10:19:07.971 182 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 10.753s 2025-09-29 10:19:07.975 183 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 10.754s 2025-09-29 10:19:07.976 184 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 10.754s 2025-09-29 10:19:07.976 185 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node3 10.905s 2025-09-29 10:19:08.127 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ]
node3 10.907s 2025-09-29 10:19:08.129 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 13.581s 2025-09-29 10:19:10.803 186 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ]
node0 13.583s 2025-09-29 10:19:10.805 187 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 16.389s 2025-09-29 10:19:13.611 188 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 16.390s 2025-09-29 10:19:13.612 189 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change CHECKING
node2 16.984s 2025-09-29 10:19:14.206 188 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 16.985s 2025-09-29 10:19:14.207 189 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node3 18.143s 2025-09-29 10:19:15.365 188 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 18.145s 2025-09-29 10:19:15.367 189 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node1 19.844s 2025-09-29 10:19:17.066 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 19.844s 2025-09-29 10:19:17.066 191 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 3.5 s in CHECKING. Now in ACTIVE
node1 19.845s 2025-09-29 10:19:17.067 192 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node1 19.902s 2025-09-29 10:19:17.124 193 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x051355517A9EFBA39D17895B7C550E1C86922D2CC30562B41A315BFB8A3C36EF', privateKey ='0x051355517A9EFBA39D17895B7C550E1C86922D2CC30562B41A315BFB8A3C36EF', signature = '0xC1F9368F1A6195E72FC96498A4E361E45BD410EA16FDC1197D5E19B8A2E542311D3B1A531E42EC137F04B616539A3DB0431A6134A1F5F80EF8EF50185C41B903',message = '0x12660A1E080110011880F1042080F1042880F1043080F104409BD5CA99F5D7B8BF3F32420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003801' }
node2 19.915s 2025-09-29 10:19:17.137 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 19.919s 2025-09-29 10:19:17.141 190 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 20.127s 2025-09-29 10:19:17.349 188 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 20.845s 2025-09-29 10:19:18.067 189 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 20.846s 2025-09-29 10:19:18.068 190 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change CHECKING
node3 21.012s 2025-09-29 10:19:18.234 191 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 2.9 s in CHECKING. Now in ACTIVE
node3 21.013s 2025-09-29 10:19:18.235 192 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 21.034s 2025-09-29 10:19:18.256 193 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xD3C72A8085CCE63F5CFE9786012D3E8B92E0124BBDF18ECF1CF496AA37BBD5CD', privateKey ='0xD3C72A8085CCE63F5CFE9786012D3E8B92E0124BBDF18ECF1CF496AA37BBD5CD', signature = '0x7691AEB0BE950B1A08A5FE63E2866133CEEF819F421C8AD9270F4AFFB5CDB2B6D963A6993CE255335D5D584C74036971D0E99AF1F21ED5F0D2B4CC66BC8D2603',message = '0x12660A1E080310031880D30E2080D30E2880D30E3080D30E40F2D7CAA3CDDDC6BA3732420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003803' }
node2 21.153s 2025-09-29 10:19:18.375 191 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 4.2 s in CHECKING. Now in ACTIVE
node2 21.154s 2025-09-29 10:19:18.376 192 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 21.178s 2025-09-29 10:19:18.400 193 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x7308D215B667C8BD29FBCD9D5FDB70F77A9AE7E64E361287453A8C227176C71C', privateKey ='0x7308D215B667C8BD29FBCD9D5FDB70F77A9AE7E64E361287453A8C227176C71C', signature = '0x232CEC48A89FD4051C773312E0568699542EF4A7005528BEF1B2546A60CBAC33AB04961A9EF8FF2746633B9326E29AA52BFD741F7680D5C6ACE8EF4F8D597807',message = '0x12660A1E080210021880E2092080E2092880E2093080E20940CD9BFBF89AD6EED95432420000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000003802' }
node3 22.096s 2025-09-29 10:19:19.318 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node0 22.107s 2025-09-29 10:19:19.329 193 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node1 22.251s 2025-09-29 10:19:19.473 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node2 22.592s 2025-09-29 10:19:19.814 196 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node2 22.738s 2025-09-29 10:19:19.960 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3
node2 22.740s 2025-09-29 10:19:19.962 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node0 22.798s 2025-09-29 10:19:20.020 202 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3
node1 22.800s 2025-09-29 10:19:20.022 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3
node0 22.802s 2025-09-29 10:19:20.024 203 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 22.802s 2025-09-29 10:19:20.024 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 22.864s 2025-09-29 10:19:20.086 205 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3
node3 22.866s 2025-09-29 10:19:20.088 206 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node2 23.020s 2025-09-29 10:19:20.242 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node2 23.024s 2025-09-29 10:19:20.246 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-29T10:19:17.115601748Z Next consensus number: 17 Legacy running event hash: a04ae05d2f8f84f250df59ec75b25f55628ab6e4d424a4f1db76a38bbbaf21518b7a5839e44b91cef5ce2cd5c2e0f018 Legacy running event mnemonic: walnut-virtual-vehicle-gift Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: d3cd1bb7f83c3d2116fc677a0b339a8c891aeec13ca4e7ad9666f8fb8abbf5169a6855ac05d986d8dded980981292db4 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / major-ivory-weasel-picnic 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 rebuild-argue-dolphin-lake 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 23.058s 2025-09-29 10:19:20.280 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 23.061s 2025-09-29 10:19:20.283 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-29T10:19:17.115601748Z Next consensus number: 17 Legacy running event hash: a04ae05d2f8f84f250df59ec75b25f55628ab6e4d424a4f1db76a38bbbaf21518b7a5839e44b91cef5ce2cd5c2e0f018 Legacy running event mnemonic: walnut-virtual-vehicle-gift Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: d3cd1bb7f83c3d2116fc677a0b339a8c891aeec13ca4e7ad9666f8fb8abbf5169a6855ac05d986d8dded980981292db4 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / major-ivory-weasel-picnic 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 rebuild-argue-dolphin-lake 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 23.063s 2025-09-29 10:19:20.285 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/09/29/2025-09-29T10+19+14.159334888Z_seq0_minr1_maxr501_orgn0.pces
node2 23.063s 2025-09-29 10:19:20.285 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/2/2025/09/29/2025-09-29T10+19+14.159334888Z_seq0_minr1_maxr501_orgn0.pces
node2 23.064s 2025-09-29 10:19:20.286 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 23.066s 2025-09-29 10:19:20.288 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 23.071s 2025-09-29 10:19:20.293 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 23.091s 2025-09-29 10:19:20.313 252 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node1 23.092s 2025-09-29 10:19:20.314 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/09/29/2025-09-29T10+19+13.642148103Z_seq0_minr1_maxr501_orgn0.pces
node1 23.093s 2025-09-29 10:19:20.315 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/1/2025/09/29/2025-09-29T10+19+13.642148103Z_seq0_minr1_maxr501_orgn0.pces
node1 23.093s 2025-09-29 10:19:20.315 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 23.094s 2025-09-29 10:19:20.316 253 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-29T10:19:17.115601748Z Next consensus number: 17 Legacy running event hash: a04ae05d2f8f84f250df59ec75b25f55628ab6e4d424a4f1db76a38bbbaf21518b7a5839e44b91cef5ce2cd5c2e0f018 Legacy running event mnemonic: walnut-virtual-vehicle-gift Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: d3cd1bb7f83c3d2116fc677a0b339a8c891aeec13ca4e7ad9666f8fb8abbf5169a6855ac05d986d8dded980981292db4 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / major-ivory-weasel-picnic 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 rebuild-argue-dolphin-lake 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 23.096s 2025-09-29 10:19:20.318 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 23.101s 2025-09-29 10:19:20.323 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 23.130s 2025-09-29 10:19:20.352 254 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/09/29/2025-09-29T10+19+14.234310195Z_seq0_minr1_maxr501_orgn0.pces
node0 23.131s 2025-09-29 10:19:20.353 255 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/29/2025-09-29T10+19+14.234310195Z_seq0_minr1_maxr501_orgn0.pces
node0 23.131s 2025-09-29 10:19:20.353 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 23.134s 2025-09-29 10:19:20.356 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 23.140s 2025-09-29 10:19:20.362 258 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 23.142s 2025-09-29 10:19:20.364 255 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3
node3 23.145s 2025-09-29 10:19:20.367 256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-29T10:19:17.115601748Z Next consensus number: 17 Legacy running event hash: a04ae05d2f8f84f250df59ec75b25f55628ab6e4d424a4f1db76a38bbbaf21518b7a5839e44b91cef5ce2cd5c2e0f018 Legacy running event mnemonic: walnut-virtual-vehicle-gift Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: d3cd1bb7f83c3d2116fc677a0b339a8c891aeec13ca4e7ad9666f8fb8abbf5169a6855ac05d986d8dded980981292db4 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / major-ivory-weasel-picnic 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 rebuild-argue-dolphin-lake 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 3 PayloadCfgSimple /3 small-crucial-observe-bar 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 moment-congress-mom-belt 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 23.185s 2025-09-29 10:19:20.407 257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/09/29/2025-09-29T10+19+14.021961263Z_seq0_minr1_maxr501_orgn0.pces
node3 23.186s 2025-09-29 10:19:20.408 258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/3/2025/09/29/2025-09-29T10+19+14.021961263Z_seq0_minr1_maxr501_orgn0.pces
node3 23.186s 2025-09-29 10:19:20.408 259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 23.189s 2025-09-29 10:19:20.411 260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 23.194s 2025-09-29 10:19:20.416 261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 24.357s 2025-09-29 10:19:21.579 259 INFO PLATFORM_STATUS <platformForkJoinThread-8> DefaultStatusStateMachine: Platform spent 3.5 s in CHECKING. Now in ACTIVE
node0 24.358s 2025-09-29 10:19:21.580 260 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 24.381s 2025-09-29 10:19:21.603 261 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x41758B2719201D36E9F9A43B107C78CB164693704E84F8C03D8282D705A02F48', privateKey ='0x41758B2719201D36E9F9A43B107C78CB164693704E84F8C03D8282D705A02F48', signature = '0xFC74E8FFFF9C95D51488082A287C16ACABAACE39C0BC25BA2F161ECCAA67B170A2D90E4B171EE595345F11E12AEBB8E5E321DB98D3A2044C6FDC8B111548690C',message = '0x12660A0A40FE8DEAB8ACE9E3816C325800000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' }
node1 1m 39.928s 2025-09-29 10:20:37.150 706 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 1m 41.058s 2025-09-29 10:20:38.280 706 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 41.191s 2025-09-29 10:20:38.413 706 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 44.411s 2025-09-29 10:20:41.633 730 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 6m 59.926s 2025-09-29 10:25:57.148 2675 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 6m 59.928s 2025-09-29 10:25:57.150 2676 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 6m 59.931s 2025-09-29 10:25:57.153 2677 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 6m 59.931s 2025-09-29 10:25:57.153 2678 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node3 7m 1.076s 2025-09-29 10:25:58.298 2687 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 7m 1.078s 2025-09-29 10:25:58.300 2688 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 7m 1.079s 2025-09-29 10:25:58.301 2689 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 7m 1.079s 2025-09-29 10:25:58.301 2690 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node2 7m 1.217s 2025-09-29 10:25:58.439 2687 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 7m 1.220s 2025-09-29 10:25:58.442 2688 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 7m 1.220s 2025-09-29 10:25:58.442 2689 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 7m 1.220s 2025-09-29 10:25:58.442 2690 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node3 7m 1.618s 2025-09-29 10:25:58.840 2691 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:57.526438786Z ]
node3 7m 1.619s 2025-09-29 10:25:58.841 2692 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:25:57.526438786Z,type=ENTER_VALIDATION]
node0 7m 1.733s 2025-09-29 10:25:58.955 2687 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:57.526438786Z ]
node0 7m 1.735s 2025-09-29 10:25:58.957 2688 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:25:57.526438786Z,type=ENTER_VALIDATION]
node1 7m 1.775s 2025-09-29 10:25:58.997 2691 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:57.526438786Z ]
node1 7m 1.776s 2025-09-29 10:25:58.998 2692 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:25:57.526438786Z,type=ENTER_VALIDATION]
node2 7m 1.849s 2025-09-29 10:25:59.071 2691 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:57.526438786Z ]
node2 7m 1.849s 2025-09-29 10:25:59.071 2692 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:25:57.526438786Z,type=ENTER_VALIDATION]
node3 7m 3.024s 2025-09-29 10:26:00.246 2697 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.747230Z ]
node3 7m 3.025s 2025-09-29 10:26:00.247 2698 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:25:58.747230Z,type=ENTER_VALIDATION]
node3 7m 3.026s 2025-09-29 10:26:00.248 2699 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.824408174Z ]
node3 7m 3.026s 2025-09-29 10:26:00.248 2700 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:25:58.824408174Z,type=ENTER_VALIDATION]
node2 7m 3.115s 2025-09-29 10:26:00.337 2705 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.747230Z ]
node2 7m 3.115s 2025-09-29 10:26:00.337 2706 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:25:58.747230Z,type=ENTER_VALIDATION]
node2 7m 3.116s 2025-09-29 10:26:00.338 2707 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.824408174Z ]
node2 7m 3.116s 2025-09-29 10:26:00.338 2708 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:25:58.824408174Z,type=ENTER_VALIDATION]
node0 7m 3.137s 2025-09-29 10:26:00.359 2701 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.747230Z ]
node0 7m 3.138s 2025-09-29 10:26:00.360 2702 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:25:58.747230Z,type=ENTER_VALIDATION]
node0 7m 3.138s 2025-09-29 10:26:00.360 2703 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.824408174Z ]
node0 7m 3.138s 2025-09-29 10:26:00.360 2704 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:25:58.824408174Z,type=ENTER_VALIDATION]
node1 7m 3.179s 2025-09-29 10:26:00.401 2705 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.747230Z ]
node1 7m 3.180s 2025-09-29 10:26:00.402 2706 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:25:58.747230Z,type=ENTER_VALIDATION]
node1 7m 3.180s 2025-09-29 10:26:00.402 2707 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:25:58.824408174Z ]
node1 7m 3.181s 2025-09-29 10:26:00.403 2708 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:25:58.824408174Z,type=ENTER_VALIDATION]
node0 7m 4.397s 2025-09-29 10:26:01.619 2705 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 7m 4.398s 2025-09-29 10:26:01.620 2706 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 7m 4.398s 2025-09-29 10:26:01.620 2707 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 7m 4.398s 2025-09-29 10:26:01.620 2708 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node1 7m 6.485s 2025-09-29 10:26:03.707 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:26:02.154372716Z ]
node1 7m 6.486s 2025-09-29 10:26:03.708 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:02.154372716Z,type=ENTER_VALIDATION]
node1 7m 6.486s 2025-09-29 10:26:03.708 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node1 7m 6.491s 2025-09-29 10:26:03.713 2728 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node1 7m 6.491s 2025-09-29 10:26:03.713 2729 INFO DEMO_INFO <<PTT: enter-validator 1>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node1 7m 6.492s 2025-09-29 10:26:03.714 2730 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1759141562154_154372716.json.gz
node1 7m 6.496s 2025-09-29 10:26:03.718 2731 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node1 7m 6.497s 2025-09-29 10:26:03.719 2732 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:02.154372716Z ]
node2 7m 6.641s 2025-09-29 10:26:03.863 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:26:02.154372716Z ]
node2 7m 6.642s 2025-09-29 10:26:03.864 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:02.154372716Z,type=ENTER_VALIDATION]
node2 7m 6.642s 2025-09-29 10:26:03.864 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node2 7m 6.647s 2025-09-29 10:26:03.869 2728 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node2 7m 6.648s 2025-09-29 10:26:03.870 2729 INFO DEMO_INFO <<PTT: enter-validator 2>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node2 7m 6.648s 2025-09-29 10:26:03.870 2730 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1759141562154_154372716.json.gz
node2 7m 6.653s 2025-09-29 10:26:03.875 2731 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node2 7m 6.653s 2025-09-29 10:26:03.875 2732 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:02.154372716Z ]
node3 7m 6.702s 2025-09-29 10:26:03.924 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:26:02.154372716Z ]
node3 7m 6.703s 2025-09-29 10:26:03.925 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:02.154372716Z,type=ENTER_VALIDATION]
node3 7m 6.703s 2025-09-29 10:26:03.925 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node3 7m 6.708s 2025-09-29 10:26:03.930 2728 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node3 7m 6.709s 2025-09-29 10:26:03.931 2729 INFO DEMO_INFO <<PTT: enter-validator 3>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node3 7m 6.710s 2025-09-29 10:26:03.932 2730 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1759141562154_154372716.json.gz
node3 7m 6.715s 2025-09-29 10:26:03.937 2731 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node3 7m 6.715s 2025-09-29 10:26:03.937 2732 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:02.154372716Z ]
node0 7m 6.762s 2025-09-29 10:26:03.984 2721 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-29T10:26:02.154372716Z ]
node0 7m 6.762s 2025-09-29 10:26:03.984 2722 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:02.154372716Z,type=ENTER_VALIDATION]
node0 7m 6.763s 2025-09-29 10:26:03.985 2723 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node0 7m 6.768s 2025-09-29 10:26:03.990 2728 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node0 7m 6.769s 2025-09-29 10:26:03.991 2729 INFO DEMO_INFO <<PTT: enter-validator 0>> VirtualMerkleTransactionHandler: There was no mismatch between the expected map and state.
node0 7m 6.770s 2025-09-29 10:26:03.992 2730 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1759141562154_154372716.json.gz
node0 7m 6.775s 2025-09-29 10:26:03.997 2731 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1759141562154_154372716.json, consensusTime = 2025-09-29T10:26:02.154372716Z ]
node0 7m 6.776s 2025-09-29 10:26:03.998 2732 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:02.154372716Z ]
node3 7m 8.659s 2025-09-29 10:26:05.881 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156324Z ]
node3 7m 8.659s 2025-09-29 10:26:05.881 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:26:04.156324Z,type=EXIT_VALIDATION]
node3 7m 8.659s 2025-09-29 10:26:05.881 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156326Z ]
node3 7m 8.660s 2025-09-29 10:26:05.882 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:26:04.156326Z,type=EXIT_VALIDATION]
node3 7m 8.660s 2025-09-29 10:26:05.882 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.396890Z ]
node3 7m 8.660s 2025-09-29 10:26:05.882 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:26:04.396890Z,type=EXIT_VALIDATION]
node3 7m 8.660s 2025-09-29 10:26:05.882 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.464887Z ]
node3 7m 8.660s 2025-09-29 10:26:05.882 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:04.464887Z,type=EXIT_VALIDATION]
node3 7m 8.661s 2025-09-29 10:26:05.883 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-09-29T10:26:04.464887Z ]
node3 7m 8.662s 2025-09-29 10:26:05.884 2752 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:04.464887Z ]
node3 7m 8.662s 2025-09-29 10:26:05.884 2753 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Waiting for final state to save before terminating
node2 7m 8.749s 2025-09-29 10:26:05.971 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156324Z ]
node2 7m 8.750s 2025-09-29 10:26:05.972 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:26:04.156324Z,type=EXIT_VALIDATION]
node2 7m 8.750s 2025-09-29 10:26:05.972 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156326Z ]
node2 7m 8.750s 2025-09-29 10:26:05.972 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:26:04.156326Z,type=EXIT_VALIDATION]
node2 7m 8.750s 2025-09-29 10:26:05.972 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.396890Z ]
node2 7m 8.750s 2025-09-29 10:26:05.972 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:26:04.396890Z,type=EXIT_VALIDATION]
node2 7m 8.751s 2025-09-29 10:26:05.973 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.464887Z ]
node2 7m 8.751s 2025-09-29 10:26:05.973 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:04.464887Z,type=EXIT_VALIDATION]
node2 7m 8.751s 2025-09-29 10:26:05.973 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-09-29T10:26:04.464887Z ]
node2 7m 8.752s 2025-09-29 10:26:05.974 2751 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:04.464887Z ]
node2 7m 8.752s 2025-09-29 10:26:05.974 2753 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Waiting for final state to save before terminating
node0 7m 8.770s 2025-09-29 10:26:05.992 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156324Z ]
node0 7m 8.771s 2025-09-29 10:26:05.993 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:26:04.156324Z,type=EXIT_VALIDATION]
node0 7m 8.771s 2025-09-29 10:26:05.993 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156326Z ]
node0 7m 8.771s 2025-09-29 10:26:05.993 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:26:04.156326Z,type=EXIT_VALIDATION]
node0 7m 8.771s 2025-09-29 10:26:05.993 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.396890Z ]
node0 7m 8.771s 2025-09-29 10:26:05.993 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:26:04.396890Z,type=EXIT_VALIDATION]
node0 7m 8.772s 2025-09-29 10:26:05.994 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.464887Z ]
node0 7m 8.772s 2025-09-29 10:26:05.994 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:04.464887Z,type=EXIT_VALIDATION]
node0 7m 8.772s 2025-09-29 10:26:05.994 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-09-29T10:26:04.464887Z ]
node0 7m 8.773s 2025-09-29 10:26:05.995 2751 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:04.464887Z ]
node0 7m 8.775s 2025-09-29 10:26:05.997 2755 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 7m 8.775s 2025-09-29 10:26:05.997 2756 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 7m 8.775s 2025-09-29 10:26:05.997 2757 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Waiting for final state to save before terminating
node1 7m 8.815s 2025-09-29 10:26:06.037 2741 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156324Z ]
node1 7m 8.815s 2025-09-29 10:26:06.037 2742 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-09-29T10:26:04.156324Z,type=EXIT_VALIDATION]
node1 7m 8.815s 2025-09-29 10:26:06.037 2743 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.156326Z ]
node1 7m 8.815s 2025-09-29 10:26:06.037 2744 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-09-29T10:26:04.156326Z,type=EXIT_VALIDATION]
node1 7m 8.816s 2025-09-29 10:26:06.038 2745 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.396890Z ]
node1 7m 8.816s 2025-09-29 10:26:06.038 2746 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-09-29T10:26:04.396890Z,type=EXIT_VALIDATION]
node1 7m 8.816s 2025-09-29 10:26:06.038 2747 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-29T10:26:04.464887Z ]
node1 7m 8.816s 2025-09-29 10:26:06.038 2748 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-29T10:26:04.464887Z,type=EXIT_VALIDATION]
node1 7m 8.816s 2025-09-29 10:26:06.038 2749 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-09-29T10:26:04.464887Z ]
node1 7m 8.817s 2025-09-29 10:26:06.039 2751 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-29T10:26:04.464887Z ]
node1 7m 8.817s 2025-09-29 10:26:06.039 2753 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Waiting for final state to save before terminating
node1 7m 10.780s 2025-09-29 10:26:08.002 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759141625
node3 7m 10.877s 2025-09-29 10:26:08.099 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759141625
node2 7m 10.947s 2025-09-29 10:26:08.169 2764 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759141625
node0 7m 11.003s 2025-09-29 10:26:08.225 2766 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1759141625
node3 8m 9.280s 2025-09-29 10:27:06.502 3161 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 721 consensusTimeStamp: 2025-09-29T10:27:05.500360Z
node3 8m 9.281s 2025-09-29 10:27:06.503 3162 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-29T10:27:05.500360Z
node3 8m 9.281s 2025-09-29 10:27:06.503 3163 INFO PLATFORM_STATUS <platformForkJoinThread-2> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node3 8m 9.282s 2025-09-29 10:27:06.504 3166 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 721 created, will eventually be written to disk, for reason: FREEZE_STATE
node3 8m 9.282s 2025-09-29 10:27:06.504 3167 TRACE DEMO_INFO <platformForkJoinThread-2> PlatformTestingToolMain: ENTERING FREEZING!
node3 8m 9.283s 2025-09-29 10:27:06.505 3168 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
node3 8m 9.283s 2025-09-29 10:27:06.505 3170 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change FREEZING
node3 8m 9.284s 2025-09-29 10:27:06.506 3171 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 721 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node3 8m 9.284s 2025-09-29 10:27:06.506 3172 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 721 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/721
node3 8m 9.285s 2025-09-29 10:27:06.507 3173 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 721
node3 8m 9.310s 2025-09-29 10:27:06.532 3184 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 8m 9.361s 2025-09-29 10:27:06.583 3163 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 721 consensusTimeStamp: 2025-09-29T10:27:05.500360Z
node0 8m 9.362s 2025-09-29 10:27:06.584 3164 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-29T10:27:05.500360Z
node0 8m 9.362s 2025-09-29 10:27:06.584 3165 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node0 8m 9.363s 2025-09-29 10:27:06.585 3168 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 721 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 8m 9.363s 2025-09-29 10:27:06.585 3169 TRACE DEMO_INFO <platformForkJoinThread-3> PlatformTestingToolMain: ENTERING FREEZING!
node0 8m 9.364s 2025-09-29 10:27:06.586 3170 TRACE DEMO_INFO <platformForkJoinThread-3> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node0 8m 9.364s 2025-09-29 10:27:06.586 3171 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change FREEZING
node0 8m 9.365s 2025-09-29 10:27:06.587 3173 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 721 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node0 8m 9.366s 2025-09-29 10:27:06.588 3174 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 721 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/721
node0 8m 9.366s 2025-09-29 10:27:06.588 3175 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 721
node0 8m 9.394s 2025-09-29 10:27:06.616 3188 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node1 8m 9.435s 2025-09-29 10:27:06.657 3161 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 721 consensusTimeStamp: 2025-09-29T10:27:05.500360Z
node1 8m 9.435s 2025-09-29 10:27:06.657 3162 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-29T10:27:05.500360Z
node1 8m 9.436s 2025-09-29 10:27:06.658 3163 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node1 8m 9.436s 2025-09-29 10:27:06.658 3166 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: ENTERING FREEZING!
node1 8m 9.436s 2025-09-29 10:27:06.658 3167 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 721 created, will eventually be written to disk, for reason: FREEZE_STATE
node1 8m 9.437s 2025-09-29 10:27:06.659 3168 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 9.437s 2025-09-29 10:27:06.659 3169 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZING
node1 8m 9.438s 2025-09-29 10:27:06.660 3171 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 721 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node1 8m 9.439s 2025-09-29 10:27:06.661 3172 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 721 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/721
node1 8m 9.439s 2025-09-29 10:27:06.661 3173 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 721
node1 8m 9.457s 2025-09-29 10:27:06.679 3184 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node2 8m 9.523s 2025-09-29 10:27:06.745 3161 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 721 consensusTimeStamp: 2025-09-29T10:27:05.500360Z
node2 8m 9.524s 2025-09-29 10:27:06.746 3162 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-29T10:27:05.500360Z
node2 8m 9.526s 2025-09-29 10:27:06.748 3165 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 721 created, will eventually be written to disk, for reason: FREEZE_STATE
node2 8m 9.527s 2025-09-29 10:27:06.749 3166 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 7.8 m in ACTIVE. Now in FREEZING
node2 8m 9.528s 2025-09-29 10:27:06.750 3168 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: ENTERING FREEZING!
node2 8m 9.529s 2025-09-29 10:27:06.751 3169 TRACE DEMO_INFO <platformForkJoinThread-1> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=400000], FCM Transactions: 0
node2 8m 9.529s 2025-09-29 10:27:06.751 3170 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 721 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node2 8m 9.529s 2025-09-29 10:27:06.751 3171 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change FREEZING
node2 8m 9.529s 2025-09-29 10:27:06.751 3172 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 721 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/721
node2 8m 9.530s 2025-09-29 10:27:06.752 3173 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 721
node2 8m 9.553s 2025-09-29 10:27:06.775 3184 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node3 8m 11.549s 2025-09-29 10:27:08.771 3235 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 721
node1 8m 11.550s 2025-09-29 10:27:08.772 3235 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 721
node3 8m 11.551s 2025-09-29 10:27:08.773 3236 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 721 Timestamp: 2025-09-29T10:27:05.500360Z Next consensus number: 12081 Legacy running event hash: b56b67cc259f9c703c0ef023b3c6813b7fc0429e0edb3a8ab6f8d669091cf54d3bad0f29bdb6dfdf6023f4376f9f89c7 Legacy running event mnemonic: famous-wet-recycle-improve Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1180245570 Root hash: b33ad904932d11f42f5d2e7b02f56ce0e58621698a078226b275010abdd24743857ee040bce9a78186bf80767e0362c1 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / occur-test-omit-direct 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 transfer-scene-denial-emerge 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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 asset-crawl-lake-donate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 8m 11.552s 2025-09-29 10:27:08.774 3236 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 721 Timestamp: 2025-09-29T10:27:05.500360Z Next consensus number: 12081 Legacy running event hash: b56b67cc259f9c703c0ef023b3c6813b7fc0429e0edb3a8ab6f8d669091cf54d3bad0f29bdb6dfdf6023f4376f9f89c7 Legacy running event mnemonic: famous-wet-recycle-improve Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1180245570 Root hash: b33ad904932d11f42f5d2e7b02f56ce0e58621698a078226b275010abdd24743857ee040bce9a78186bf80767e0362c1 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / occur-test-omit-direct 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 transfer-scene-denial-emerge 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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 asset-crawl-lake-donate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 8m 11.562s 2025-09-29 10:27:08.784 3237 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/1/2025/09/29/2025-09-29T10+19+43.175215782Z_seq4_minr9_maxr42_orgn0.pces Last file: data/saved/preconsensus-events/1/2025/09/29/2025-09-29T10+25+10.176045305Z_seq33_minr515_maxr560_orgn0.pces
node1 8m 11.562s 2025-09-29 10:27:08.784 3238 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 694 File: data/saved/preconsensus-events/1/2025/09/29/2025-09-29T10+26+48.334908025Z_seq39_minr659_maxr721_orgn0.pces
node1 8m 11.562s 2025-09-29 10:27:08.784 3239 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 8m 11.562s 2025-09-29 10:27:08.784 3240 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 8m 11.562s 2025-09-29 10:27:08.784 3237 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/3/2025/09/29/2025-09-29T10+20+15.489097787Z_seq9_minr58_maxr101_orgn0.pces Last file: data/saved/preconsensus-events/3/2025/09/29/2025-09-29T10+23+31.996840311Z_seq25_minr364_maxr409_orgn0.pces
node3 8m 11.562s 2025-09-29 10:27:08.784 3238 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 694 File: data/saved/preconsensus-events/3/2025/09/29/2025-09-29T10+26+48.453461662Z_seq39_minr659_maxr721_orgn0.pces
node1 8m 11.563s 2025-09-29 10:27:08.785 3241 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 721 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/721 {"round":721,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/721/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node3 8m 11.563s 2025-09-29 10:27:08.785 3239 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 8m 11.563s 2025-09-29 10:27:08.785 3240 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 8m 11.564s 2025-09-29 10:27:08.786 3242 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-29T10:27:05.500360Z ]
node3 8m 11.564s 2025-09-29 10:27:08.786 3241 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 721 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/721 {"round":721,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/721/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node1 8m 11.565s 2025-09-29 10:27:08.787 3243 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.1 s in FREEZING. Now in FREEZE_COMPLETE
node1 8m 11.565s 2025-09-29 10:27:08.787 3244 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-29T10:27:05.500360Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 8m 11.565s 2025-09-29 10:27:08.787 3245 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node3 8m 11.565s 2025-09-29 10:27:08.787 3242 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-29T10:27:05.500360Z ]
node3 8m 11.566s 2025-09-29 10:27:08.788 3243 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-29T10:27:05.500360Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 8m 11.567s 2025-09-29 10:27:08.789 3244 INFO PLATFORM_STATUS <platformForkJoinThread-3> DefaultStatusStateMachine: Platform spent 2.3 s in FREEZING. Now in FREEZE_COMPLETE
node3 8m 11.568s 2025-09-29 10:27:08.790 3245 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 8m 11.850s 2025-09-29 10:27:09.072 3237 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 721
node0 8m 11.852s 2025-09-29 10:27:09.074 3238 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 721 Timestamp: 2025-09-29T10:27:05.500360Z Next consensus number: 12081 Legacy running event hash: b56b67cc259f9c703c0ef023b3c6813b7fc0429e0edb3a8ab6f8d669091cf54d3bad0f29bdb6dfdf6023f4376f9f89c7 Legacy running event mnemonic: famous-wet-recycle-improve Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1180245570 Root hash: b33ad904932d11f42f5d2e7b02f56ce0e58621698a078226b275010abdd24743857ee040bce9a78186bf80767e0362c1 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / occur-test-omit-direct 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 transfer-scene-denial-emerge 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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 asset-crawl-lake-donate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 8m 11.862s 2025-09-29 10:27:09.084 3239 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 41 preconsensus files on disk.
First file: data/saved/preconsensus-events/0/2025/09/29/2025-09-29T10+24+34.115195259Z_seq30_minr452_maxr501_orgn0.pces Last file: data/saved/preconsensus-events/0/2025/09/29/2025-09-29T10+23+44.848884854Z_seq26_minr382_maxr427_orgn0.pces
node0 8m 11.863s 2025-09-29 10:27:09.085 3240 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 2 preconsensus event files meeting specified criteria to copy.
Lower bound: 694 First file to copy: data/saved/preconsensus-events/0/2025/09/29/2025-09-29T10+26+45.870486401Z_seq39_minr656_maxr716_orgn0.pces Last file to copy: data/saved/preconsensus-events/0/2025/09/29/2025-09-29T10+27+04.501082759Z_seq40_minr690_maxr754_orgn0.pces
node0 8m 11.863s 2025-09-29 10:27:09.085 3241 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 2 preconsensus event file(s)
node0 8m 11.864s 2025-09-29 10:27:09.086 3242 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 2 preconsensus event file(s)
node0 8m 11.864s 2025-09-29 10:27:09.086 3243 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 721 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/721 {"round":721,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/721/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 8m 11.866s 2025-09-29 10:27:09.088 3244 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-29T10:27:05.500360Z ]
node0 8m 11.866s 2025-09-29 10:27:09.088 3245 INFO PLATFORM_STATUS <platformForkJoinThread-4> DefaultStatusStateMachine: Platform spent 2.5 s in FREEZING. Now in FREEZE_COMPLETE
node0 8m 11.867s 2025-09-29 10:27:09.089 3246 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-29T10:27:05.500360Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 8m 11.867s 2025-09-29 10:27:09.089 3247 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node2 8m 12.285s 2025-09-29 10:27:09.507 3235 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 721
node2 8m 12.287s 2025-09-29 10:27:09.509 3236 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 721 Timestamp: 2025-09-29T10:27:05.500360Z Next consensus number: 12081 Legacy running event hash: b56b67cc259f9c703c0ef023b3c6813b7fc0429e0edb3a8ab6f8d669091cf54d3bad0f29bdb6dfdf6023f4376f9f89c7 Legacy running event mnemonic: famous-wet-recycle-improve Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1180245570 Root hash: b33ad904932d11f42f5d2e7b02f56ce0e58621698a078226b275010abdd24743857ee040bce9a78186bf80767e0362c1 First BR Version: SemanticVersion[major=0, minor=0, patch=0, pre=, build=] Last round before BR: 0 Lowest Judge Gen before BR 0 (root) PlatformTestingToolState / occur-test-omit-direct 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 transfer-scene-denial-emerge 1 VirtualMap RosterService.ROSTERS /1 scrap-balcony-father-gate 2 SingletonNode RosterService.ROSTER_STATE /2 empty-select-palace-wash 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 asset-crawl-lake-donate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 8m 12.302s 2025-09-29 10:27:09.524 3237 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 40 preconsensus files on disk.
First file: data/saved/preconsensus-events/2/2025/09/29/2025-09-29T10+25+22.449738806Z_seq34_minr531_maxr577_orgn0.pces Last file: data/saved/preconsensus-events/2/2025/09/29/2025-09-29T10+23+55.919465100Z_seq27_minr398_maxr443_orgn0.pces
node2 8m 12.303s 2025-09-29 10:27:09.525 3238 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 694 File: data/saved/preconsensus-events/2/2025/09/29/2025-09-29T10+26+48.250096215Z_seq39_minr659_maxr721_orgn0.pces
node2 8m 12.303s 2025-09-29 10:27:09.525 3239 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 8m 12.303s 2025-09-29 10:27:09.525 3240 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 8m 12.304s 2025-09-29 10:27:09.526 3241 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 721 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/721 {"round":721,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/721/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 8m 12.305s 2025-09-29 10:27:09.527 3242 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-29T10:27:05.500360Z ]
node2 8m 12.306s 2025-09-29 10:27:09.528 3243 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 2.8 s in FREEZING. Now in FREEZE_COMPLETE
node2 8m 12.307s 2025-09-29 10:27:09.529 3244 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node2 8m 12.307s 2025-09-29 10:27:09.529 3245 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-29T10:27:05.500360Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 9m 11.615s 2025-09-29 10:28:08.837 3248 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 0 to 1>> NetworkUtils: Connection broken: 0 -> 1
java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.initiateHeartbeat(HeartbeatPeerProtocol.java:112) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.runProtocol(HeartbeatPeerProtocol.java:156) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583)
node0 9m 11.771s 2025-09-29 10:28:08.993 3249 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 0 to 2>> NetworkUtils: Connection broken: 0 -> 2
java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-29T10:28:08.992701964Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:245) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-29T10:28:08.992701964Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:159) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:444) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:382) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:245) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:242) ... 6 more Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:164) ... 11 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$sendEventsTheyNeed$8(SyncUtils.java:229) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 1 more Caused by: java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readEventsINeed$9(SyncUtils.java:273) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:157) ... 11 more
node0 9m 12.264s 2025-09-29 10:28:09.486 3250 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 0 to 3>> NetworkUtils: Connection broken: 0 -> 3
java.net.SocketException: Connection reset at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:318) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583)