Node ID



Columns











Log Level






Log Marker










Class











































node0 0.000ns 2025-09-23 05:42:03.978 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 93.000ms 2025-09-23 05:42:04.071 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 225.000ms 2025-09-23 05:42:04.203 3 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 232.000ms 2025-09-23 05:42:04.210 4 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node0 262.000ms 2025-09-23 05:42:04.240 5 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 264.000ms 2025-09-23 05:42:04.242 6 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 265.000ms 2025-09-23 05:42:04.243 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 266.000ms 2025-09-23 05:42:04.244 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 266.000ms 2025-09-23 05:42:04.244 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 267.000ms 2025-09-23 05:42:04.245 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 267.000ms 2025-09-23 05:42:04.245 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 268.000ms 2025-09-23 05:42:04.246 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 268.000ms 2025-09-23 05:42:04.246 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 269.000ms 2025-09-23 05:42:04.247 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 269.000ms 2025-09-23 05:42:04.247 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 269.000ms 2025-09-23 05:42:04.247 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 270.000ms 2025-09-23 05:42:04.248 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 270.000ms 2025-09-23 05:42:04.248 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 271.000ms 2025-09-23 05:42:04.249 19 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 700.000ms 2025-09-23 05:42:04.678 22 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node0 1.898s 2025-09-23 05:42:05.876 23 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1196ms
node0 1.947s 2025-09-23 05:42:05.925 24 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 2.009s 2025-09-23 05:42:05.987 25 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 2.009s 2025-09-23 05:42:05.987 26 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 2.536s 2025-09-23 05:42:06.514 27 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 2.611s 2025-09-23 05:42:06.589 30 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 2.612s 2025-09-23 05:42:06.590 31 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 2.612s 2025-09-23 05:42:06.590 32 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 2.613s 2025-09-23 05:42:06.591 33 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 2.613s 2025-09-23 05:42:06.591 34 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 2.613s 2025-09-23 05:42:06.591 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 2.614s 2025-09-23 05:42:06.592 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 2.614s 2025-09-23 05:42:06.592 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 3.461s 2025-09-23 05:42:07.439 46 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 3.466s 2025-09-23 05:42:07.444 47 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node0 4.583s 2025-09-23 05:42:08.561 48 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26236019] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=283582, randomLong=7909531911120198848, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13620, randomLong=5134711415680787460, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1429739, data=35, exception=null] OS Health Check Report - Complete (took 1025 ms)
node0 4.615s 2025-09-23 05:42:08.593 49 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 4.624s 2025-09-23 05:42:08.602 50 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 4.629s 2025-09-23 05:42:08.607 51 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 4.711s 2025-09-23 05:42:08.689 52 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "50000000000", "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": "aMbb8w==", "port": 30124 }, { "ipAddressV4": "CoAAYA==", "port": 30124 }] }] }
node0 4.819s 2025-09-23 05:42:08.797 53 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 4.820s 2025-09-23 05:42:08.798 54 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 4.836s 2025-09-23 05:42:08.814 55 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: aedab3c7106b777d1b00d2c72fe14160c75bea47bc8c4219e7b022fb8407afb00f92bc262f660f930670d51bcb31a7fc (root) PlatformTestingToolState / cave-mango-aspect-use 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 silk-major-trash-source 2 VirtualMap RosterService.ROSTERS /2 wise-arm-palace-test 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 journey-bus-million-shy
node0 5.033s 2025-09-23 05:42:09.011 57 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 5.039s 2025-09-23 05:42:09.017 58 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 5.050s 2025-09-23 05:42:09.028 59 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 5.050s 2025-09-23 05:42:09.028 60 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 5.051s 2025-09-23 05:42:09.029 61 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 5.051s 2025-09-23 05:42:09.029 62 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 5.052s 2025-09-23 05:42:09.030 63 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 5.052s 2025-09-23 05:42:09.030 64 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 5.053s 2025-09-23 05:42:09.031 65 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 5.053s 2025-09-23 05:42:09.031 66 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 5.053s 2025-09-23 05:42:09.031 67 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 5.054s 2025-09-23 05:42:09.032 68 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 5.054s 2025-09-23 05:42:09.032 69 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 5.055s 2025-09-23 05:42:09.033 70 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 5.055s 2025-09-23 05:42:09.033 71 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 5.056s 2025-09-23 05:42:09.034 72 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 5.056s 2025-09-23 05:42:09.034 73 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON FCM-VMerkle-Basic-SingleNode-2.5k-3m.json
node0 5.078s 2025-09-23 05:42:09.056 74 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 5.079s 2025-09-23 05:42:09.057 75 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 5.080s 2025-09-23 05:42:09.058 76 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 5.080s 2025-09-23 05:42:09.058 77 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 5.081s 2025-09-23 05:42:09.059 78 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 5.082s 2025-09-23 05:42:09.060 79 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node0 5.083s 2025-09-23 05:42:09.061 80 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 5.085s 2025-09-23 05:42:09.063 81 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 2500.0
node0 5.093s 2025-09-23 05:42:09.071 82 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@243ef4ac
node0 5.095s 2025-09-23 05:42:09.073 83 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 39000
node0 5.095s 2025-09-23 05:42:09.073 84 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 39000 accounts.
node0 5.102s 2025-09-23 05:42:09.080 89 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@1d418854, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5226dfe8,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@1c1dbd4f,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@44dd6f0f,snapshotInProgress=false]
node0 5.115s 2025-09-23 05:42:09.093 90 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 5.116s 2025-09-23 05:42:09.094 91 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 5.123s 2025-09-23 05:42:09.101 92 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is 455689218631484099
node0 5.123s 2025-09-23 05:42:09.101 93 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 5.213s 2025-09-23 05:42:09.191 94 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 5.214s 2025-09-23 05:42:09.192 95 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 5.218s 2025-09-23 05:42:09.196 96 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 5.219s 2025-09-23 05:42:09.197 97 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 5.220s 2025-09-23 05:42:09.198 98 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 5.222s 2025-09-23 05:42:09.200 99 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 5.222s 2025-09-23 05:42:09.200 100 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 5.223s 2025-09-23 05:42:09.201 101 INFO STARTUP <<start-node-0>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node0 5.224s 2025-09-23 05:42:09.202 102 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 5.225s 2025-09-23 05:42:09.203 103 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 332.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 5.225s 2025-09-23 05:42:09.203 104 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 5.230s 2025-09-23 05:42:09.208 105 INFO PLATFORM_STATUS <platformForkJoinThread-1> DefaultStatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 5.231s 2025-09-23 05:42:09.209 106 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 8.061s 2025-09-23 05:42:12.039 107 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 8.064s 2025-09-23 05:42:12.042 108 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 15.322s 2025-09-23 05:42:19.300 109 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 15.323s 2025-09-23 05:42:19.301 110 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change CHECKING
node0 15.497s 2025-09-23 05:42:19.475 111 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node0 15.498s 2025-09-23 05:42:19.476 112 INFO PLATFORM_STATUS <platformForkJoinThread-5> DefaultStatusStateMachine: Platform spent 174.0 ms in CHECKING. Now in ACTIVE
node0 15.498s 2025-09-23 05:42:19.476 113 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 15.587s 2025-09-23 05:42:19.565 114 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x4E4CA0880D7277F3DA87C3D4327571E77D7F28892ACC5B87EB92FD66542D4E4A', privateKey ='0x4E4CA0880D7277F3DA87C3D4327571E77D7F28892ACC5B87EB92FD66542D4E4A', signature = '0x0F3CEAFA913DE309391BC800E29993D211E19A5AE893246A8F27584DCC4CA0C2ECD7D1E4E20AC85DFA5670C64E48109064B0A9879A042DDA50A7C9CB21BBE80A',message = '0x12660A0A40EBAEA5B0F1CE8CC15D325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' }
node0 15.615s 2025-09-23 05:42:19.593 117 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node0 15.682s 2025-09-23 05:42:19.660 132 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3
node0 15.684s 2025-09-23 05:42:19.662 133 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3
node0 15.989s 2025-09-23 05:42:19.967 201 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3
node0 15.993s 2025-09-23 05:42:19.971 202 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-09-23T05:42:19.458714727Z Next consensus number: 3 Legacy running event hash: cd20ac5b54b7a65f1148ae26f47c7a25e0740bc80f6197b5f020e07198ff34fe51e8b10745f69ce344edb6ffcb3a4fab Legacy running event mnemonic: foster-input-notice-crouch Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 04e1f4eefe40e9e2d395d377a060e79f27a40ca0f4dad356fca8f992a0a7dddc09ace0ceb68d6afa6bf45dd0e4de9e76 (root) PlatformTestingToolState / order-girl-day-sense 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 slice-galaxy-dynamic-cargo 1 SingletonNode RosterService.ROSTER_STATE /1 silk-major-trash-source 2 VirtualMap RosterService.ROSTERS /2 wise-arm-palace-test 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 virus-bird-ancient-indicate 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 journey-bus-million-shy
node0 16.038s 2025-09-23 05:42:20.016 207 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/09/23/2025-09-23T05+42+19.342742130Z_seq0_minr1_maxr501_orgn0.pces
node0 16.039s 2025-09-23 05:42:20.017 208 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/23/2025-09-23T05+42+19.342742130Z_seq0_minr1_maxr501_orgn0.pces
node0 16.039s 2025-09-23 05:42:20.017 209 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 16.041s 2025-09-23 05:42:20.019 210 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 16.047s 2025-09-23 05:42:20.025 211 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]
node0 23.615s 2025-09-23 05:42:27.593 1120 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node0 23.623s 2025-09-23 05:42:27.601 1155 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 27.575s 2025-09-23 05:42:31.553 1612 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 31.559s 2025-09-23 05:42:35.537 2085 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 31.664s 2025-09-23 05:42:35.642 2106 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_UPDATE
node0 35.437s 2025-09-23 05:42:39.415 2563 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 39.465s 2025-09-23 05:42:43.443 3044 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 39.736s 2025-09-23 05:42:43.714 3089 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_TRANSFER
node0 43.541s 2025-09-23 05:42:47.519 3542 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 44.519s 2025-09-23 05:42:48.497 3647 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_DELETE
node0 44.520s 2025-09-23 05:42:48.498 3648 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM test for sequential mode, stop generating 4 >= 4
node0 46.034s 2025-09-23 05:42:50.012 3839 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 48.036s 2025-09-23 05:42:52.014 4074 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 50.037s 2025-09-23 05:42:54.015 4311 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 52.035s 2025-09-23 05:42:56.013 4548 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 53.606s 2025-09-23 05:42:57.584 4719 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 55.620s 2025-09-23 05:42:59.598 4954 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 57.193s 2025-09-23 05:43:01.171 5143 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 59.205s 2025-09-23 05:43:03.183 5378 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 1.014m 2025-09-23 05:43:04.814 5587 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 1m 4.806s 2025-09-23 05:43:08.784 6038 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node0 1m 4.810s 2025-09-23 05:43:08.788 6039 INFO DEMO_INFO <<app: appMain 0>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node0 1m 4.811s 2025-09-23 05:43:08.789 6040 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 1m 4.813s 2025-09-23 05:43:08.791 6041 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 1m 4.813s 2025-09-23 05:43:08.791 6042 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node0 1m 4.989s 2025-09-23 05:43:08.967 6079 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-23T05:43:08.838920893Z ]
node0 1m 4.990s 2025-09-23 05:43:08.968 6080 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-23T05:43:08.838920893Z,type=ENTER_VALIDATION]
node0 1m 4.990s 2025-09-23 05:43:08.968 6081 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-23T05:43:08.838920893Z ]
node0 1m 4.995s 2025-09-23 05:43:08.973 6082 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1758606188838_838920893.json, consensusTime = 2025-09-23T05:43:08.838920893Z ]
node0 1m 5.073s 2025-09-23 05:43:09.051 6099 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1758606188838_838920893.json.gz
node0 1m 5.776s 2025-09-23 05:43:09.754 6152 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1758606188838_838920893.json, consensusTime = 2025-09-23T05:43:08.838920893Z ]
node0 1m 5.777s 2025-09-23 05:43:09.755 6153 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-23T05:43:08.838920893Z ]
node0 1m 5.946s 2025-09-23 05:43:09.924 6194 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-23T05:43:09.798426539Z ]
node0 1m 5.947s 2025-09-23 05:43:09.925 6195 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-09-23T05:43:09.798426539Z,type=EXIT_VALIDATION]
node0 1m 5.947s 2025-09-23 05:43:09.925 6196 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = EXIT_VALIDATION, consensusTime = 2025-09-23T05:43:09.798426539Z ]
node0 1m 5.949s 2025-09-23 05:43:09.927 6197 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-23T05:43:09.798426539Z ]
node0 1m 5.951s 2025-09-23 05:43:09.929 6198 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 1m 5.951s 2025-09-23 05:43:09.929 6199 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 1m 5.951s 2025-09-23 05:43:09.929 6200 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Waiting for final state to save before terminating
node0 1m 6.134s 2025-09-23 05:43:10.112 6225 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1758606249
node0 2m 5.167s 2025-09-23 05:44:09.145 13159 INFO STARTUP <<scheduler TransactionHandler>> DefaultTransactionHandler: Submitting freeze period entered action for consensus round: 1829 consensusTimeStamp: 2025-09-23T05:44:09.018612381Z
2025-09-23 05:44: 13158 INFO EVENT_STREAM <<scheduler ConsensusEngine>> DefaultConsensusEventStream: ConsensusTimestamp of the last Event to be written into file before restarting: 2025-09-23T05:44:09.018612381Z
node0 2m 5.168s 2025-09-23 05:44:09.146 13160 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 1.8 m in ACTIVE. Now in FREEZING
node0 2m 5.168s 2025-09-23 05:44:09.146 13161 TRACE DEMO_INFO <platformForkJoinThread-7> PlatformTestingToolMain: ENTERING FREEZING!
node0 2m 5.169s 2025-09-23 05:44:09.147 13164 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 1829 created, will eventually be written to disk, for reason: FREEZE_STATE
node0 2m 5.169s 2025-09-23 05:44:09.147 13165 TRACE DEMO_INFO <platformForkJoinThread-7> PlatformTestingToolMain: total submitted transactions: DefaultCounter[category=Debug:info,name=tranSub,description=number of transactions submitted to platform,unit=,format=%d,dataType=INT,value=123000], FCM Transactions: 36000
node0 2m 5.169s 2025-09-23 05:44:09.147 13166 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change FREEZING
node0 2m 5.171s 2025-09-23 05:44:09.149 13169 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> DefaultStateSnapshotManager: Freeze state written to disk for round 1829 was not fully signed. This is expected.
Collected signatures representing 0/50000000000 (0.0%) weight.
node0 2m 5.172s 2025-09-23 05:44:09.150 13170 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Started writing round 1829 state to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/1829
node0 2m 5.172s 2025-09-23 05:44:09.150 13171 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/12 for round 1829
node0 2m 5.200s 2025-09-23 05:44:09.178 13183 INFO FREEZE <<scheduler ConsensusEngine>> TimestampStreamFileWriter: TimestampStreamFileWriter finished writing the last object, is stopped
node0 2m 5.795s 2025-09-23 05:44:09.773 13256 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> MerkleTreeSnapshotWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/12 for round 1829
node0 2m 5.798s 2025-09-23 05:44:09.776 13257 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 1829 Timestamp: 2025-09-23T05:44:09.018612381Z Next consensus number: 1829 Legacy running event hash: d3048e0af7f80bb937a7b8c52473accb23d45e8a780e9cf9922002897e6c0fa0db74ca95716db218150fdf847c0b32cc Legacy running event mnemonic: panel-disagree-absurd-jaguar Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: -1367961292 Root hash: cd7cc53b0bfeaf65d76d9f3359b55c48bafca66df46f353ca75039139f445d8274127df2006a52e170094cba1ff032ac (root) PlatformTestingToolState / explain-flavor-lemon-beach 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 letter-rose-armed-pretty 1 SingletonNode RosterService.ROSTER_STATE /1 silk-major-trash-source 2 VirtualMap RosterService.ROSTERS /2 wise-arm-palace-test 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 enforce-blouse-siren-noise 0 MerkleMap /5/0 carry-jaguar-element-wagon 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 road-throw-shy-soda 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 betray-that-common-tissue 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 journey-bus-million-shy
node0 2m 5.807s 2025-09-23 05:44:09.785 13258 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 5 preconsensus files on disk.
First file: data/saved/preconsensus-events/0/2025/09/23/2025-09-23T05+42+58.943086860Z_seq2_minr631_maxr1057_orgn0.pces Last file: data/saved/preconsensus-events/0/2025/09/23/2025-09-23T05+42+39.263092670Z_seq1_minr303_maxr658_orgn0.pces
node0 2m 5.808s 2025-09-23 05:44:09.786 13259 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1802 File: data/saved/preconsensus-events/0/2025/09/23/2025-09-23T05+43+49.343389352Z_seq4_minr1471_maxr1970_orgn0.pces
node0 2m 5.808s 2025-09-23 05:44:09.786 13260 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 2m 5.809s 2025-09-23 05:44:09.787 13261 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 2m 5.809s 2025-09-23 05:44:09.787 13262 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 1829 to disk. Reason: FREEZE_STATE, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/1829 {"round":1829,"freezeState":true,"reason":"FREEZE_STATE","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/1829/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node0 2m 5.811s 2025-09-23 05:44:09.789 13263 INFO DEMO_QUORUM <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-23T05:44:09.018612381Z ]
node0 2m 5.812s 2025-09-23 05:44:09.790 13264 INFO PLATFORM_STATUS <platformForkJoinThread-7> DefaultStatusStateMachine: Platform spent 643.0 ms in FREEZING. Now in FREEZE_COMPLETE
node0 2m 5.813s 2025-09-23 05:44:09.791 13265 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change FREEZE_COMPLETE
node0 2m 5.813s 2025-09-23 05:44:09.791 13266 INFO DEMO_INFO <<scheduler StateSnapshotManager>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-23T05:44:09.018612381Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]