| node3 | 0.000ns | 2025-09-22 11:26:40.252 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node3 | 83.000ms | 2025-09-22 11:26:40.335 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node3 | 97.000ms | 2025-09-22 11:26:40.349 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 98.000ms | 2025-09-22 11:26:40.350 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 208.000ms | 2025-09-22 11:26:40.460 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [3] are set to run locally | |
| node3 | 214.000ms | 2025-09-22 11:26:40.466 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 241.000ms | 2025-09-22 11:26:40.493 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 242.000ms | 2025-09-22 11:26:40.494 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 242.000ms | 2025-09-22 11:26:40.494 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 243.000ms | 2025-09-22 11:26:40.495 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 243.000ms | 2025-09-22 11:26:40.495 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 244.000ms | 2025-09-22 11:26:40.496 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 244.000ms | 2025-09-22 11:26:40.496 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 245.000ms | 2025-09-22 11:26:40.497 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 245.000ms | 2025-09-22 11:26:40.497 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 245.000ms | 2025-09-22 11:26:40.497 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 246.000ms | 2025-09-22 11:26:40.498 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 246.000ms | 2025-09-22 11:26:40.498 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 246.000ms | 2025-09-22 11:26:40.498 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 247.000ms | 2025-09-22 11:26:40.499 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 247.000ms | 2025-09-22 11:26:40.499 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 628.000ms | 2025-09-22 11:26:40.880 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 659.000ms | 2025-09-22 11:26:40.911 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 748.000ms | 2025-09-22 11:26:41.000 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 764.000ms | 2025-09-22 11:26:41.016 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 765.000ms | 2025-09-22 11:26:41.017 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 804.000ms | 2025-09-22 11:26:41.056 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 879.000ms | 2025-09-22 11:26:41.131 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [2] are set to run locally | |
| node2 | 886.000ms | 2025-09-22 11:26:41.138 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node1 | 895.000ms | 2025-09-22 11:26:41.147 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node1 | 911.000ms | 2025-09-22 11:26:41.163 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 912.000ms | 2025-09-22 11:26:41.164 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 914.000ms | 2025-09-22 11:26:41.166 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 915.000ms | 2025-09-22 11:26:41.167 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 916.000ms | 2025-09-22 11:26:41.168 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 917.000ms | 2025-09-22 11:26:41.169 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 917.000ms | 2025-09-22 11:26:41.169 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 917.000ms | 2025-09-22 11:26:41.169 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 918.000ms | 2025-09-22 11:26:41.170 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 919.000ms | 2025-09-22 11:26:41.171 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 919.000ms | 2025-09-22 11:26:41.171 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 919.000ms | 2025-09-22 11:26:41.171 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 920.000ms | 2025-09-22 11:26:41.172 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 920.000ms | 2025-09-22 11:26:41.172 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 920.000ms | 2025-09-22 11:26:41.172 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 921.000ms | 2025-09-22 11:26:41.173 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 921.000ms | 2025-09-22 11:26:41.173 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node1 | 1.031s | 2025-09-22 11:26:41.283 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [1] are set to run locally | |
| node1 | 1.040s | 2025-09-22 11:26:41.292 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node1 | 1.071s | 2025-09-22 11:26:41.323 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.073s | 2025-09-22 11:26:41.325 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.073s | 2025-09-22 11:26:41.325 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.074s | 2025-09-22 11:26:41.326 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 1.074s | 2025-09-22 11:26:41.326 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.074s | 2025-09-22 11:26:41.326 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 1.075s | 2025-09-22 11:26:41.327 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.076s | 2025-09-22 11:26:41.328 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.076s | 2025-09-22 11:26:41.328 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.077s | 2025-09-22 11:26:41.329 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.077s | 2025-09-22 11:26:41.329 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 1.078s | 2025-09-22 11:26:41.330 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.078s | 2025-09-22 11:26:41.330 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 1.079s | 2025-09-22 11:26:41.331 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.079s | 2025-09-22 11:26:41.331 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 1.332s | 2025-09-22 11:26:41.584 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node1 | 1.503s | 2025-09-22 11:26:41.755 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 1.522s | 2025-09-22 11:26:41.774 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 893ms | |
| node3 | 1.530s | 2025-09-22 11:26:41.782 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 1.530s | 2025-09-22 11:26:41.782 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 1.572s | 2025-09-22 11:26:41.824 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 1.630s | 2025-09-22 11:26:41.882 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node3 | 1.630s | 2025-09-22 11:26:41.882 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 2.268s | 2025-09-22 11:26:42.520 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 934ms | |
| node2 | 2.274s | 2025-09-22 11:26:42.526 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 2.274s | 2025-09-22 11:26:42.526 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 2.311s | 2025-09-22 11:26:42.563 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 2.331s | 2025-09-22 11:26:42.583 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 827ms | |
| node1 | 2.338s | 2025-09-22 11:26:42.590 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 2.339s | 2025-09-22 11:26:42.591 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 2.370s | 2025-09-22 11:26:42.622 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node2 | 2.371s | 2025-09-22 11:26:42.623 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 2.400s | 2025-09-22 11:26:42.652 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 2.463s | 2025-09-22 11:26:42.715 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node1 | 2.464s | 2025-09-22 11:26:42.716 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node0 | 2.582s | 2025-09-22 11:26:42.834 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node0 | 2.707s | 2025-09-22 11:26:42.959 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 2.732s | 2025-09-22 11:26:42.984 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 2.734s | 2025-09-22 11:26:42.986 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 2.896s | 2025-09-22 11:26:43.148 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [0] are set to run locally | |
| node0 | 2.906s | 2025-09-22 11:26:43.158 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node0 | 2.943s | 2025-09-22 11:26:43.195 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 2.946s | 2025-09-22 11:26:43.198 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 2.947s | 2025-09-22 11:26:43.199 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.948s | 2025-09-22 11:26:43.200 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 2.949s | 2025-09-22 11:26:43.201 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.949s | 2025-09-22 11:26:43.201 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 2.950s | 2025-09-22 11:26:43.202 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.951s | 2025-09-22 11:26:43.203 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 2.952s | 2025-09-22 11:26:43.204 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 2.952s | 2025-09-22 11:26:43.204 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.952s | 2025-09-22 11:26:43.204 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 2.953s | 2025-09-22 11:26:43.205 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.953s | 2025-09-22 11:26:43.205 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 2.954s | 2025-09-22 11:26:43.206 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.955s | 2025-09-22 11:26:43.207 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node0 | 3.478s | 2025-09-22 11:26:43.730 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 3.543s | 2025-09-22 11:26:43.795 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 3.618s | 2025-09-22 11:26:43.870 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node3 | 3.619s | 2025-09-22 11:26:43.871 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 3.619s | 2025-09-22 11:26:43.871 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 3.620s | 2025-09-22 11:26:43.872 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.620s | 2025-09-22 11:26:43.872 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 3.620s | 2025-09-22 11:26:43.872 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.620s | 2025-09-22 11:26:43.872 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 3.621s | 2025-09-22 11:26:43.873 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.370s | 2025-09-22 11:26:44.622 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node3 | 4.375s | 2025-09-22 11:26:44.627 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node2 | 4.401s | 2025-09-22 11:26:44.653 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node1 | 4.493s | 2025-09-22 11:26:44.745 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node2 | 4.496s | 2025-09-22 11:26:44.748 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node2 | 4.497s | 2025-09-22 11:26:44.749 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 4.497s | 2025-09-22 11:26:44.749 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 4.498s | 2025-09-22 11:26:44.750 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.498s | 2025-09-22 11:26:44.750 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 4.498s | 2025-09-22 11:26:44.750 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.499s | 2025-09-22 11:26:44.751 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 4.499s | 2025-09-22 11:26:44.751 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.576s | 2025-09-22 11:26:44.828 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node1 | 4.577s | 2025-09-22 11:26:44.829 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 4.577s | 2025-09-22 11:26:44.829 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 4.578s | 2025-09-22 11:26:44.830 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.578s | 2025-09-22 11:26:44.830 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 4.578s | 2025-09-22 11:26:44.830 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.579s | 2025-09-22 11:26:44.831 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 4.579s | 2025-09-22 11:26:44.831 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 4.587s | 2025-09-22 11:26:44.839 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1107ms | |
| node0 | 4.594s | 2025-09-22 11:26:44.846 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 4.594s | 2025-09-22 11:26:44.846 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 4.643s | 2025-09-22 11:26:44.895 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node0 | 4.720s | 2025-09-22 11:26:44.972 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node0 | 4.721s | 2025-09-22 11:26:44.973 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 5.297s | 2025-09-22 11:26:45.549 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node2 | 5.302s | 2025-09-22 11:26:45.554 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node1 | 5.384s | 2025-09-22 11:26:45.636 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node1 | 5.389s | 2025-09-22 11:26:45.641 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node3 | 5.490s | 2025-09-22 11:26:45.742 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=27225997] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=193080, randomLong=9137718627614640174, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=17250, randomLong=4094731337379258464, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1128590, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms) | |||||||||
| node3 | 5.519s | 2025-09-22 11:26:45.771 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 5.526s | 2025-09-22 11:26:45.778 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node3 | 5.530s | 2025-09-22 11:26:45.782 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node3 | 5.608s | 2025-09-22 11:26:45.860 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "I96i5w==", "port": 30124 }, { "ipAddressV4": "CoAP6w==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Igmz3g==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IkVtJQ==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "Ij+eOg==", "port": 30127 }, { "ipAddressV4": "CoAP6Q==", "port": 30127 }] }] } | |||||||||
| node3 | 5.700s | 2025-09-22 11:26:45.952 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node3 | 5.701s | 2025-09-22 11:26:45.953 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node3 | 5.716s | 2025-09-22 11:26:45.968 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: fd1cf914bd873846b3c07c92045f84e982ed8fa41d33016eaefe6ca12dec69d1c9aac712b180e9281fd31b6a5d173fcd (root) PlatformTestingToolState / frame-talk-execute-angle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 5.896s | 2025-09-22 11:26:46.148 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node3 | 5.900s | 2025-09-22 11:26:46.152 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node3 | 5.908s | 2025-09-22 11:26:46.160 | 64 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node3 | 5.909s | 2025-09-22 11:26:46.161 | 65 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node3 | 5.909s | 2025-09-22 11:26:46.161 | 66 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node3 | 5.910s | 2025-09-22 11:26:46.162 | 67 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node3 | 5.910s | 2025-09-22 11:26:46.162 | 68 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node3 | 5.910s | 2025-09-22 11:26:46.162 | 69 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node3 | 5.911s | 2025-09-22 11:26:46.163 | 70 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node3 | 5.911s | 2025-09-22 11:26:46.163 | 71 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node3 | 5.912s | 2025-09-22 11:26:46.164 | 72 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node3 | 5.912s | 2025-09-22 11:26:46.164 | 73 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node3 | 5.912s | 2025-09-22 11:26:46.164 | 74 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node3 | 5.912s | 2025-09-22 11:26:46.164 | 75 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node3 | 5.913s | 2025-09-22 11:26:46.165 | 76 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node3 | 5.913s | 2025-09-22 11:26:46.165 | 77 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node3 | 5.913s | 2025-09-22 11:26:46.165 | 78 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 5.931s | 2025-09-22 11:26:46.183 | 79 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | insertSeq = true | |
| node3 | 5.931s | 2025-09-22 11:26:46.183 | 80 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | appendSig = true | |
| node3 | 5.931s | 2025-09-22 11:26:46.183 | 81 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | variedSize = false | |
| node3 | 5.932s | 2025-09-22 11:26:46.184 | 82 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | payloadByteSize = 100 | |
| node3 | 5.932s | 2025-09-22 11:26:46.184 | 83 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | maxByteSize = 100 | |
| node3 | 5.932s | 2025-09-22 11:26:46.184 | 84 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node3 | 5.933s | 2025-09-22 11:26:46.185 | 85 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node3 | 5.934s | 2025-09-22 11:26:46.186 | 86 | INFO | DEMO_INFO | <<start-node-3>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 5.939s | 2025-09-22 11:26:46.191 | 87 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@79dfe5b7 | |
| node3 | 5.940s | 2025-09-22 11:26:46.192 | 88 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node3 | 5.940s | 2025-09-22 11:26:46.192 | 89 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node3 | 5.947s | 2025-09-22 11:26:46.199 | 94 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@2e9dd831, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@451cd7f8,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@39cab528,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@b6efabd,snapshotInProgress=false] | |
| node3 | 5.955s | 2025-09-22 11:26:46.207 | 95 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node3 | 5.955s | 2025-09-22 11:26:46.207 | 96 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node3 | 5.960s | 2025-09-22 11:26:46.212 | 97 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -4061322889995910086 | |
| node3 | 5.960s | 2025-09-22 11:26:46.212 | 98 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node3 | 6.037s | 2025-09-22 11:26:46.289 | 99 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | Starting platform 3 | |
| node3 | 6.038s | 2025-09-22 11:26:46.290 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node3 | 6.042s | 2025-09-22 11:26:46.294 | 101 | INFO | STARTUP | <<start-node-3>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node3 | 6.043s | 2025-09-22 11:26:46.295 | 102 | INFO | STARTUP | <<start-node-3>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node3 | 6.044s | 2025-09-22 11:26:46.296 | 103 | INFO | STARTUP | <<start-node-3>> | InputWireChecks: | All input wires have been bound. | |
| node3 | 6.046s | 2025-09-22 11:26:46.298 | 104 | WARN | STARTUP | <<start-node-3>> | PcesFileTracker: | No preconsensus event files available | |
| node3 | 6.047s | 2025-09-22 11:26:46.299 | 105 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node3 | 6.048s | 2025-09-22 11:26:46.300 | 106 | INFO | STARTUP | <<start-node-3>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node3 | 6.049s | 2025-09-22 11:26:46.301 | 107 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 starts transactions ........ | |
| node3 | 6.049s | 2025-09-22 11:26:46.301 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 285.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node3 | 6.052s | 2025-09-22 11:26:46.304 | 109 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node3 | 6.053s | 2025-09-22 11:26:46.305 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node3 | 6.053s | 2025-09-22 11:26:46.305 | 111 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 6.417s | 2025-09-22 11:26:46.669 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26260158] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=287180, randomLong=-3609708050506280197, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13270, randomLong=-8194407215102497212, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1199940, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms) | |||||||||
| node2 | 6.447s | 2025-09-22 11:26:46.699 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node2 | 6.454s | 2025-09-22 11:26:46.706 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node2 | 6.459s | 2025-09-22 11:26:46.711 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 6.505s | 2025-09-22 11:26:46.757 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26195533] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=166180, randomLong=-8380140816143070356, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13730, randomLong=9185656740562386635, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1184470, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms) | |||||||||
| node1 | 6.536s | 2025-09-22 11:26:46.788 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node2 | 6.542s | 2025-09-22 11:26:46.794 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "I96i5w==", "port": 30124 }, { "ipAddressV4": "CoAP6w==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Igmz3g==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IkVtJQ==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "Ij+eOg==", "port": 30127 }, { "ipAddressV4": "CoAP6Q==", "port": 30127 }] }] } | |||||||||
| node1 | 6.544s | 2025-09-22 11:26:46.796 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node1 | 6.549s | 2025-09-22 11:26:46.801 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 6.632s | 2025-09-22 11:26:46.884 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "I96i5w==", "port": 30124 }, { "ipAddressV4": "CoAP6w==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Igmz3g==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IkVtJQ==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "Ij+eOg==", "port": 30127 }, { "ipAddressV4": "CoAP6Q==", "port": 30127 }] }] } | |||||||||
| node2 | 6.639s | 2025-09-22 11:26:46.891 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node2 | 6.639s | 2025-09-22 11:26:46.891 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node2 | 6.654s | 2025-09-22 11:26:46.906 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: fd1cf914bd873846b3c07c92045f84e982ed8fa41d33016eaefe6ca12dec69d1c9aac712b180e9281fd31b6a5d173fcd (root) PlatformTestingToolState / frame-talk-execute-angle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node1 | 6.736s | 2025-09-22 11:26:46.988 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node1 | 6.737s | 2025-09-22 11:26:46.989 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node1 | 6.754s | 2025-09-22 11:26:47.006 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: fd1cf914bd873846b3c07c92045f84e982ed8fa41d33016eaefe6ca12dec69d1c9aac712b180e9281fd31b6a5d173fcd (root) PlatformTestingToolState / frame-talk-execute-angle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 6.779s | 2025-09-22 11:26:47.031 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node2 | 6.851s | 2025-09-22 11:26:47.103 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node2 | 6.856s | 2025-09-22 11:26:47.108 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node0 | 6.861s | 2025-09-22 11:26:47.113 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node0 | 6.862s | 2025-09-22 11:26:47.114 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 6.862s | 2025-09-22 11:26:47.114 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 6.863s | 2025-09-22 11:26:47.115 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 6.863s | 2025-09-22 11:26:47.115 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 6.863s | 2025-09-22 11:26:47.115 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 6.863s | 2025-09-22 11:26:47.115 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 6.864s | 2025-09-22 11:26:47.116 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 6.866s | 2025-09-22 11:26:47.118 | 64 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node2 | 6.866s | 2025-09-22 11:26:47.118 | 65 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 6.867s | 2025-09-22 11:26:47.119 | 66 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node2 | 6.867s | 2025-09-22 11:26:47.119 | 67 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node2 | 6.867s | 2025-09-22 11:26:47.119 | 68 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node2 | 6.868s | 2025-09-22 11:26:47.120 | 69 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node2 | 6.868s | 2025-09-22 11:26:47.120 | 70 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node2 | 6.868s | 2025-09-22 11:26:47.120 | 71 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node2 | 6.869s | 2025-09-22 11:26:47.121 | 72 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 6.869s | 2025-09-22 11:26:47.121 | 73 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node2 | 6.869s | 2025-09-22 11:26:47.121 | 74 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 6.869s | 2025-09-22 11:26:47.121 | 75 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node2 | 6.870s | 2025-09-22 11:26:47.122 | 76 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node2 | 6.870s | 2025-09-22 11:26:47.122 | 77 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node2 | 6.870s | 2025-09-22 11:26:47.122 | 78 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node2 | 6.887s | 2025-09-22 11:26:47.139 | 79 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | insertSeq = true | |
| node2 | 6.887s | 2025-09-22 11:26:47.139 | 80 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | appendSig = true | |
| node2 | 6.888s | 2025-09-22 11:26:47.140 | 81 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | variedSize = false | |
| node2 | 6.888s | 2025-09-22 11:26:47.140 | 82 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | payloadByteSize = 100 | |
| node2 | 6.888s | 2025-09-22 11:26:47.140 | 83 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | maxByteSize = 100 | |
| node2 | 6.889s | 2025-09-22 11:26:47.141 | 84 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node2 | 6.889s | 2025-09-22 11:26:47.141 | 85 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node2 | 6.891s | 2025-09-22 11:26:47.143 | 86 | INFO | DEMO_INFO | <<start-node-2>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node2 | 6.895s | 2025-09-22 11:26:47.147 | 87 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@26eff5e9 | |
| node2 | 6.896s | 2025-09-22 11:26:47.148 | 88 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 6.897s | 2025-09-22 11:26:47.149 | 89 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 6.904s | 2025-09-22 11:26:47.156 | 94 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@72f254b0, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6daf64c9,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@44e5f5c8,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@7acf3ef1,snapshotInProgress=false] | |
| node2 | 6.913s | 2025-09-22 11:26:47.165 | 95 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node2 | 6.913s | 2025-09-22 11:26:47.165 | 96 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node2 | 6.918s | 2025-09-22 11:26:47.170 | 97 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -2432372723496604377 | |
| node2 | 6.918s | 2025-09-22 11:26:47.170 | 98 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 6.958s | 2025-09-22 11:26:47.210 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node1 | 6.963s | 2025-09-22 11:26:47.215 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 6.972s | 2025-09-22 11:26:47.224 | 64 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node1 | 6.973s | 2025-09-22 11:26:47.225 | 65 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node1 | 6.973s | 2025-09-22 11:26:47.225 | 66 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node1 | 6.973s | 2025-09-22 11:26:47.225 | 67 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node1 | 6.974s | 2025-09-22 11:26:47.226 | 68 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node1 | 6.974s | 2025-09-22 11:26:47.226 | 69 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node1 | 6.974s | 2025-09-22 11:26:47.226 | 70 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node1 | 6.975s | 2025-09-22 11:26:47.227 | 71 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node1 | 6.975s | 2025-09-22 11:26:47.227 | 72 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node1 | 6.975s | 2025-09-22 11:26:47.227 | 73 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node1 | 6.976s | 2025-09-22 11:26:47.228 | 74 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node1 | 6.976s | 2025-09-22 11:26:47.228 | 75 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node1 | 6.976s | 2025-09-22 11:26:47.228 | 76 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node1 | 6.976s | 2025-09-22 11:26:47.228 | 77 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node1 | 6.976s | 2025-09-22 11:26:47.228 | 78 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node1 | 6.993s | 2025-09-22 11:26:47.245 | 79 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | insertSeq = true | |
| node1 | 6.993s | 2025-09-22 11:26:47.245 | 80 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | appendSig = true | |
| node1 | 6.994s | 2025-09-22 11:26:47.246 | 81 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | variedSize = false | |
| node1 | 6.994s | 2025-09-22 11:26:47.246 | 82 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | payloadByteSize = 100 | |
| node1 | 6.995s | 2025-09-22 11:26:47.247 | 83 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | maxByteSize = 100 | |
| node1 | 6.995s | 2025-09-22 11:26:47.247 | 84 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node1 | 6.995s | 2025-09-22 11:26:47.247 | 85 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node1 | 6.997s | 2025-09-22 11:26:47.249 | 86 | INFO | DEMO_INFO | <<start-node-1>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node2 | 6.997s | 2025-09-22 11:26:47.249 | 99 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | Starting platform 2 | |
| node2 | 6.998s | 2025-09-22 11:26:47.250 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 7.001s | 2025-09-22 11:26:47.253 | 87 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@1dcaec67 | |
| node2 | 7.001s | 2025-09-22 11:26:47.253 | 101 | INFO | STARTUP | <<start-node-2>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 7.002s | 2025-09-22 11:26:47.254 | 88 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 7.002s | 2025-09-22 11:26:47.254 | 102 | INFO | STARTUP | <<start-node-2>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 7.003s | 2025-09-22 11:26:47.255 | 89 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 7.003s | 2025-09-22 11:26:47.255 | 103 | INFO | STARTUP | <<start-node-2>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 7.005s | 2025-09-22 11:26:47.257 | 104 | WARN | STARTUP | <<start-node-2>> | PcesFileTracker: | No preconsensus event files available | |
| node2 | 7.006s | 2025-09-22 11:26:47.258 | 105 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node2 | 7.007s | 2025-09-22 11:26:47.259 | 106 | INFO | STARTUP | <<start-node-2>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node2 | 7.008s | 2025-09-22 11:26:47.260 | 107 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 starts transactions ........ | |
| node2 | 7.008s | 2025-09-22 11:26:47.260 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 299.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 7.010s | 2025-09-22 11:26:47.262 | 94 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@221fb850, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@6331cdc4,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@40356a6,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@78bb70f2,snapshotInProgress=false] | |
| node2 | 7.012s | 2025-09-22 11:26:47.264 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node2 | 7.012s | 2025-09-22 11:26:47.264 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node2 | 7.013s | 2025-09-22 11:26:47.265 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 7.018s | 2025-09-22 11:26:47.270 | 95 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node1 | 7.018s | 2025-09-22 11:26:47.270 | 96 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node1 | 7.023s | 2025-09-22 11:26:47.275 | 97 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 1536681387626487629 | |
| node1 | 7.024s | 2025-09-22 11:26:47.276 | 98 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 7.103s | 2025-09-22 11:26:47.355 | 99 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | Starting platform 1 | |
| node1 | 7.105s | 2025-09-22 11:26:47.357 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 7.108s | 2025-09-22 11:26:47.360 | 101 | INFO | STARTUP | <<start-node-1>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 7.110s | 2025-09-22 11:26:47.362 | 102 | INFO | STARTUP | <<start-node-1>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 7.110s | 2025-09-22 11:26:47.362 | 103 | INFO | STARTUP | <<start-node-1>> | InputWireChecks: | All input wires have been bound. | |
| node1 | 7.112s | 2025-09-22 11:26:47.364 | 104 | WARN | STARTUP | <<start-node-1>> | PcesFileTracker: | No preconsensus event files available | |
| node1 | 7.112s | 2025-09-22 11:26:47.364 | 105 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node1 | 7.113s | 2025-09-22 11:26:47.365 | 106 | INFO | STARTUP | <<start-node-1>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node1 | 7.114s | 2025-09-22 11:26:47.366 | 107 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 starts transactions ........ | |
| node1 | 7.114s | 2025-09-22 11:26:47.366 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 308.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 7.118s | 2025-09-22 11:26:47.370 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node1 | 7.119s | 2025-09-22 11:26:47.371 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node1 | 7.119s | 2025-09-22 11:26:47.371 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node0 | 7.710s | 2025-09-22 11:26:47.962 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node0 | 7.716s | 2025-09-22 11:26:47.968 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 8.868s | 2025-09-22 11:26:49.120 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26330615] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=149509, randomLong=-8754865611420384449, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11200, randomLong=-4672314875172131922, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1015340, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node0 | 8.901s | 2025-09-22 11:26:49.153 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node0 | 8.909s | 2025-09-22 11:26:49.161 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node0 | 8.914s | 2025-09-22 11:26:49.166 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node3 | 8.917s | 2025-09-22 11:26:49.169 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ] | |
| node3 | 8.920s | 2025-09-22 11:26:49.172 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 9.003s | 2025-09-22 11:26:49.255 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "I96i5w==", "port": 30124 }, { "ipAddressV4": "CoAP6w==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "Igmz3g==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "IkVtJQ==", "port": 30126 }, { "ipAddressV4": "CoAP6A==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "Ij+eOg==", "port": 30127 }, { "ipAddressV4": "CoAP6Q==", "port": 30127 }] }] } | |||||||||
| node0 | 9.109s | 2025-09-22 11:26:49.361 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node0 | 9.110s | 2025-09-22 11:26:49.362 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node0 | 9.126s | 2025-09-22 11:26:49.378 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: fd1cf914bd873846b3c07c92045f84e982ed8fa41d33016eaefe6ca12dec69d1c9aac712b180e9281fd31b6a5d173fcd (root) PlatformTestingToolState / frame-talk-execute-angle 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 9.363s | 2025-09-22 11:26:49.615 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node0 | 9.369s | 2025-09-22 11:26:49.621 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node0 | 9.378s | 2025-09-22 11:26:49.630 | 64 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node0 | 9.379s | 2025-09-22 11:26:49.631 | 65 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node0 | 9.379s | 2025-09-22 11:26:49.631 | 66 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node0 | 9.380s | 2025-09-22 11:26:49.632 | 67 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node0 | 9.380s | 2025-09-22 11:26:49.632 | 68 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node0 | 9.381s | 2025-09-22 11:26:49.633 | 69 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node0 | 9.381s | 2025-09-22 11:26:49.633 | 70 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node0 | 9.381s | 2025-09-22 11:26:49.633 | 71 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node0 | 9.382s | 2025-09-22 11:26:49.634 | 72 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node0 | 9.382s | 2025-09-22 11:26:49.634 | 73 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node0 | 9.382s | 2025-09-22 11:26:49.634 | 74 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node0 | 9.383s | 2025-09-22 11:26:49.635 | 75 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node0 | 9.383s | 2025-09-22 11:26:49.635 | 76 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node0 | 9.383s | 2025-09-22 11:26:49.635 | 77 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node0 | 9.383s | 2025-09-22 11:26:49.635 | 78 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node0 | 9.402s | 2025-09-22 11:26:49.654 | 79 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | insertSeq = true | |
| node0 | 9.402s | 2025-09-22 11:26:49.654 | 80 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | appendSig = true | |
| node0 | 9.403s | 2025-09-22 11:26:49.655 | 81 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | variedSize = false | |
| node0 | 9.403s | 2025-09-22 11:26:49.655 | 82 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | payloadByteSize = 100 | |
| node0 | 9.404s | 2025-09-22 11:26:49.656 | 83 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | maxByteSize = 100 | |
| node0 | 9.404s | 2025-09-22 11:26:49.656 | 84 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 9.405s | 2025-09-22 11:26:49.657 | 85 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 9.406s | 2025-09-22 11:26:49.658 | 86 | INFO | DEMO_INFO | <<start-node-0>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 9.412s | 2025-09-22 11:26:49.664 | 87 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@4c98fb40 | |
| node0 | 9.413s | 2025-09-22 11:26:49.665 | 88 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node0 | 9.413s | 2025-09-22 11:26:49.665 | 89 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node0 | 9.421s | 2025-09-22 11:26:49.673 | 94 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@1289aae7, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@279c2331,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@5e60cde9,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@69a178e3,snapshotInProgress=false] | |
| node0 | 9.430s | 2025-09-22 11:26:49.682 | 95 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node0 | 9.430s | 2025-09-22 11:26:49.682 | 96 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 9.435s | 2025-09-22 11:26:49.687 | 97 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 7386438746657130058 | |
| node0 | 9.435s | 2025-09-22 11:26:49.687 | 98 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 9.532s | 2025-09-22 11:26:49.784 | 99 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | Starting platform 0 | |
| node0 | 9.535s | 2025-09-22 11:26:49.787 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node0 | 9.540s | 2025-09-22 11:26:49.792 | 101 | INFO | STARTUP | <<start-node-0>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 9.541s | 2025-09-22 11:26:49.793 | 102 | INFO | STARTUP | <<start-node-0>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node0 | 9.542s | 2025-09-22 11:26:49.794 | 103 | INFO | STARTUP | <<start-node-0>> | InputWireChecks: | All input wires have been bound. | |
| node0 | 9.545s | 2025-09-22 11:26:49.797 | 104 | WARN | STARTUP | <<start-node-0>> | PcesFileTracker: | No preconsensus event files available | |
| node0 | 9.546s | 2025-09-22 11:26:49.798 | 105 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node0 | 9.548s | 2025-09-22 11:26:49.800 | 106 | INFO | STARTUP | <<start-node-0>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node0 | 9.549s | 2025-09-22 11:26:49.801 | 107 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 starts transactions ........ | |
| node0 | 9.552s | 2025-09-22 11:26:49.804 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 368.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node0 | 9.557s | 2025-09-22 11:26:49.809 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node0 | 9.559s | 2025-09-22 11:26:49.811 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 6.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node0 | 9.559s | 2025-09-22 11:26:49.811 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 9.874s | 2025-09-22 11:26:50.126 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ] | |
| node2 | 9.877s | 2025-09-22 11:26:50.129 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node1 | 9.979s | 2025-09-22 11:26:50.231 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting1.csv' ] | |
| node1 | 9.981s | 2025-09-22 11:26:50.233 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 12.387s | 2025-09-22 11:26:52.639 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ] | |
| node0 | 12.390s | 2025-09-22 11:26:52.642 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node3 | 16.145s | 2025-09-22 11:26:56.397 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node3 | 16.147s | 2025-09-22 11:26:56.399 | 115 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 17.104s | 2025-09-22 11:26:57.356 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node2 | 17.105s | 2025-09-22 11:26:57.357 | 115 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 17.212s | 2025-09-22 11:26:57.464 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node1 | 17.214s | 2025-09-22 11:26:57.466 | 115 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 18.919s | 2025-09-22 11:26:59.171 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.921s | 2025-09-22 11:26:59.173 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 18.929s | 2025-09-22 11:26:59.181 | 116 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 2.8 s in CHECKING. Now in ACTIVE | |
| node3 | 18.929s | 2025-09-22 11:26:59.181 | 117 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 18.929s | 2025-09-22 11:26:59.181 | 118 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 19.011s | 2025-09-22 11:26:59.263 | 119 | TRACE | STARTUP | <<app: appMain 3>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x338D072E2D4C1037623EF07BEDD488230AA71B09469831925CF5624B79163A41', privateKey ='0x338D072E2D4C1037623EF07BEDD488230AA71B09469831925CF5624B79163A41', signature = '0xD67FE9406082556A3B1212D9A5723A7CC1EC57C85C14C14CA54282CFD58C9C219A2C798C7A07C2C49720F1DB389A046236875EF999DE033FB2883BE034C4F003',message = '0x12660A1A0803100318A03820A03828A03830A03840CED2C187E4CE94EC123244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' } | |
| node0 | 19.194s | 2025-09-22 11:26:59.446 | 114 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node0 | 19.642s | 2025-09-22 11:26:59.894 | 115 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node0 | 19.643s | 2025-09-22 11:26:59.895 | 116 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 19.901s | 2025-09-22 11:27:00.153 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 2.7 s in CHECKING. Now in ACTIVE | |
| node2 | 19.903s | 2025-09-22 11:27:00.155 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 2.8 s in CHECKING. Now in ACTIVE | |
| node1 | 19.904s | 2025-09-22 11:27:00.156 | 118 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 19.905s | 2025-09-22 11:27:00.157 | 118 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 19.941s | 2025-09-22 11:27:00.193 | 119 | TRACE | STARTUP | <<app: appMain 2>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x69A04185FE311280FF1D29D48FF0F5D0041449BF1A2667967C7F66DD7F1A3D7D', privateKey ='0x69A04185FE311280FF1D29D48FF0F5D0041449BF1A2667967C7F66DD7F1A3D7D', signature = '0x8B754B89F387C8278619350DC198E3CF413CBD7834297539CE6AD5645B3A74ED9160C2D7B57D4AF64B280FEF29DA1FAA1562F1075C246212FD8E10A69A3B7700',message = '0x1A6B0A1B08021002180120A18D0628914E30914E40FBEDC9C3A6A68FCBE2012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' } | |
| node1 | 19.951s | 2025-09-22 11:27:00.203 | 119 | TRACE | STARTUP | <<app: appMain 1>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x5F8126B951DAB66243FE035D26562301A9BB3FE73B45DFF50A9D9B3159A19B51', privateKey ='0x5F8126B951DAB66243FE035D26562301A9BB3FE73B45DFF50A9D9B3159A19B51', signature = '0x1181A748449F3E48EAEAF11F4DD803969A5C6A883025356014019F27A2C973C78F17F527AD00EC95396BF59AC680D3861E6BF6736D5CB4F8C2B6070266621609',message = '0x1A6B0A1A08011001180120A18D0628914E30914E4087FA9798AAEFDBA3722A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00101' } | |
| node3 | 21.327s | 2025-09-22 11:27:01.579 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node0 | 21.349s | 2025-09-22 11:27:01.601 | 119 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node1 | 21.397s | 2025-09-22 11:27:01.649 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node2 | 21.468s | 2025-09-22 11:27:01.720 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node3 | 21.741s | 2025-09-22 11:27:01.993 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 | |
| node3 | 21.743s | 2025-09-22 11:27:01.995 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node1 | 21.805s | 2025-09-22 11:27:02.057 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 | |
| node1 | 21.807s | 2025-09-22 11:27:02.059 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node2 | 21.875s | 2025-09-22 11:27:02.127 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 | |
| node2 | 21.878s | 2025-09-22 11:27:02.130 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node3 | 22.002s | 2025-09-22 11:27:02.254 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node3 | 22.005s | 2025-09-22 11:27:02.257 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-22T11:26:59.156795Z Next consensus number: 19 Legacy running event hash: 491de9a20d9464b39f02c8f91da4ec27a251a46f3890effaf62d4afc4a22e009b0fbf97676d862f9b280155635e0aa6c Legacy running event mnemonic: casual-slim-raw-nose Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 308d32c6915cf067adc29730099a8450216b2d7d4320fda1597410201a55b23cf15a54048d14a867217f9528a59ed6ca (root) PlatformTestingToolState / balance-flee-stand-veteran 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 parade-total-awkward-report 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 22.013s | 2025-09-22 11:27:02.265 | 134 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 | |
| node0 | 22.016s | 2025-09-22 11:27:02.268 | 135 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 22.024s | 2025-09-22 11:27:02.276 | 143 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 2.4 s in CHECKING. Now in ACTIVE | |
| node0 | 22.024s | 2025-09-22 11:27:02.276 | 145 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 22.034s | 2025-09-22 11:27:02.286 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/3/2025/09/22/2025-09-22T11+26+56.438577752Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 22.035s | 2025-09-22 11:27:02.287 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/3/2025/09/22/2025-09-22T11+26+56.438577752Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 22.035s | 2025-09-22 11:27:02.287 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node3 | 22.036s | 2025-09-22 11:27:02.288 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node3 | 22.040s | 2025-09-22 11:27:02.292 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node1 | 22.072s | 2025-09-22 11:27:02.324 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node1 | 22.076s | 2025-09-22 11:27:02.328 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-22T11:26:59.156795Z Next consensus number: 19 Legacy running event hash: 491de9a20d9464b39f02c8f91da4ec27a251a46f3890effaf62d4afc4a22e009b0fbf97676d862f9b280155635e0aa6c Legacy running event mnemonic: casual-slim-raw-nose Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 308d32c6915cf067adc29730099a8450216b2d7d4320fda1597410201a55b23cf15a54048d14a867217f9528a59ed6ca (root) PlatformTestingToolState / balance-flee-stand-veteran 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 parade-total-awkward-report 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 22.096s | 2025-09-22 11:27:02.348 | 150 | TRACE | STARTUP | <<app: appMain 0>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x064830ADB07BFE0660E43254E99904085B3406432DCB31DC97425993C3157A4D', privateKey ='0x064830ADB07BFE0660E43254E99904085B3406432DCB31DC97425993C3157A4D', signature = '0xA43446A738707D071395574AD9BB0DC11DB8DB6A058CAEE79F8F6C22FA7712DDA36513191EAE6688318AC63C7F0D6BD694BC56A22D48A26DF62E469E090A6907',message = '0x12660A0A40899A83B6E2AE858E7E325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' } | |
| node1 | 22.108s | 2025-09-22 11:27:02.360 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/1/2025/09/22/2025-09-22T11+26+56.842535809Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 22.109s | 2025-09-22 11:27:02.361 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/1/2025/09/22/2025-09-22T11+26+56.842535809Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 22.109s | 2025-09-22 11:27:02.361 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node1 | 22.110s | 2025-09-22 11:27:02.362 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 22.115s | 2025-09-22 11:27:02.367 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node2 | 22.150s | 2025-09-22 11:27:02.402 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node2 | 22.154s | 2025-09-22 11:27:02.406 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-22T11:26:59.156795Z Next consensus number: 19 Legacy running event hash: 491de9a20d9464b39f02c8f91da4ec27a251a46f3890effaf62d4afc4a22e009b0fbf97676d862f9b280155635e0aa6c Legacy running event mnemonic: casual-slim-raw-nose Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 308d32c6915cf067adc29730099a8450216b2d7d4320fda1597410201a55b23cf15a54048d14a867217f9528a59ed6ca (root) PlatformTestingToolState / balance-flee-stand-veteran 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 parade-total-awkward-report 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node2 | 22.185s | 2025-09-22 11:27:02.437 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/2/2025/09/22/2025-09-22T11+26+56.779866350Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 22.185s | 2025-09-22 11:27:02.437 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/2/2025/09/22/2025-09-22T11+26+56.779866350Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 22.186s | 2025-09-22 11:27:02.438 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node2 | 22.187s | 2025-09-22 11:27:02.439 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 22.191s | 2025-09-22 11:27:02.443 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node0 | 22.296s | 2025-09-22 11:27:02.548 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 22.299s | 2025-09-22 11:27:02.551 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-22T11:26:59.156795Z Next consensus number: 19 Legacy running event hash: 491de9a20d9464b39f02c8f91da4ec27a251a46f3890effaf62d4afc4a22e009b0fbf97676d862f9b280155635e0aa6c Legacy running event mnemonic: casual-slim-raw-nose Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 308d32c6915cf067adc29730099a8450216b2d7d4320fda1597410201a55b23cf15a54048d14a867217f9528a59ed6ca (root) PlatformTestingToolState / balance-flee-stand-veteran 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 parade-total-awkward-report 1 VirtualMap RosterService.ROSTERS /1 canal-base-shoe-right 2 SingletonNode RosterService.ROSTER_STATE /2 mouse-lottery-wisdom-awkward 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 22.330s | 2025-09-22 11:27:02.582 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/0/2025/09/22/2025-09-22T11+26+56.769824293Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 22.330s | 2025-09-22 11:27:02.582 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/0/2025/09/22/2025-09-22T11+26+56.769824293Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 22.330s | 2025-09-22 11:27:02.582 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 22.332s | 2025-09-22 11:27:02.584 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node0 | 22.336s | 2025-09-22 11:27:02.588 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node3 | 25.670s | 2025-09-22 11:27:05.922 | 242 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 26.473s | 2025-09-22 11:27:06.725 | 242 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 26.701s | 2025-09-22 11:27:06.953 | 242 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 27.388s | 2025-09-22 11:27:07.640 | 247 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 28.198s | 2025-09-22 11:27:08.450 | 263 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 28.521s | 2025-09-22 11:27:08.773 | 263 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 28.557s | 2025-09-22 11:27:08.809 | 262 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 30.327s | 2025-09-22 11:27:10.579 | 283 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 59.313s | 2025-09-22 11:27:39.565 | 604 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 59.885s | 2025-09-22 11:27:40.137 | 608 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 1.014m | 2025-09-22 11:27:41.093 | 624 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 1m 1.228s | 2025-09-22 11:27:41.480 | 624 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 1m 23.147s | 2025-09-22 11:28:03.399 | 845 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node3 | 1m 23.149s | 2025-09-22 11:28:03.401 | 846 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node3 | 1m 23.151s | 2025-09-22 11:28:03.403 | 847 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | node3 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 23.655s | 2025-09-22 11:28:03.907 | 845 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node2 | 1m 23.657s | 2025-09-22 11:28:03.909 | 846 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node2 | 1m 23.658s | 2025-09-22 11:28:03.910 | 847 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | node2 submits a transaction SAVE_EXPECTED_MAP | |
| node1 | 1m 24.324s | 2025-09-22 11:28:04.576 | 845 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node1 | 1m 24.376s | 2025-09-22 11:28:04.628 | 850 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node1 | 1m 24.377s | 2025-09-22 11:28:04.629 | 851 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | node1 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 24.973s | 2025-09-22 11:28:05.225 | 852 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 25.223s | 2025-09-22 11:28:05.475 | 865 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node3 | 1m 25.253s | 2025-09-22 11:28:05.505 | 868 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 25.290s | 2025-09-22 11:28:05.542 | 868 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 25.771s | 2025-09-22 11:28:06.023 | 869 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 25.826s | 2025-09-22 11:28:06.078 | 869 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node0 | 1m 25.947s | 2025-09-22 11:28:06.199 | 866 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node3 | 1m 25.947s | 2025-09-22 11:28:06.199 | 869 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 26.385s | 2025-09-22 11:28:06.637 | 870 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node0 | 1m 26.632s | 2025-09-22 11:28:06.884 | 867 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node3 | 1m 26.662s | 2025-09-22 11:28:06.914 | 870 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 26.700s | 2025-09-22 11:28:06.952 | 870 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node0 | 1m 27.615s | 2025-09-22 11:28:07.867 | 888 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node0 | 1m 27.615s | 2025-09-22 11:28:07.867 | 889 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node0 | 1m 27.616s | 2025-09-22 11:28:07.868 | 890 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | node0 submits a transaction SAVE_EXPECTED_MAP | |
| node1 | 1m 30.011s | 2025-09-22 11:28:10.263 | 911 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1758540488352_352740308.json.gz | |
| node2 | 1m 30.056s | 2025-09-22 11:28:10.308 | 911 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1758540488352_352740308.json.gz | |
| node0 | 1m 30.175s | 2025-09-22 11:28:10.427 | 911 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1758540488352_352740308.json.gz | |
| node3 | 1m 30.182s | 2025-09-22 11:28:10.434 | 911 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1758540488352_352740308.json.gz | |
| node1 | 1m 30.316s | 2025-09-22 11:28:10.568 | 912 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node2 | 1m 30.362s | 2025-09-22 11:28:10.614 | 912 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 30.476s | 2025-09-22 11:28:10.728 | 912 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node0 | 1m 30.479s | 2025-09-22 11:28:10.731 | 912 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 31.269s | 2025-09-22 11:28:11.521 | 933 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 1m 31.342s | 2025-09-22 11:28:11.594 | 917 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 1m 32.229s | 2025-09-22 11:28:12.481 | 933 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 32.359s | 2025-09-22 11:28:12.611 | 933 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 1m 32.956s | 2025-09-22 11:28:13.208 | 938 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 1m 33.033s | 2025-09-22 11:28:13.285 | 938 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 1m 33.770s | 2025-09-22 11:28:14.022 | 954 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 1m 33.892s | 2025-09-22 11:28:14.144 | 954 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 2m 5.052s | 2025-09-22 11:28:45.304 | 1255 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 2m 5.104s | 2025-09-22 11:28:45.356 | 1256 | INFO | DEMO_INFO | <<app: appMain 0>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node0 | 2m 5.104s | 2025-09-22 11:28:45.356 | 1257 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Stop generating transactions | |
| node0 | 2m 5.107s | 2025-09-22 11:28:45.359 | 1258 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | node 0 sent ENTER_VALIDATION Message | |
| node0 | 2m 5.109s | 2025-09-22 11:28:45.361 | 1259 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 finished generating all transactions. | |
| node3 | 2m 5.212s | 2025-09-22 11:28:45.464 | 1255 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 2m 5.214s | 2025-09-22 11:28:45.466 | 1256 | INFO | DEMO_INFO | <<app: appMain 3>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node3 | 2m 5.214s | 2025-09-22 11:28:45.466 | 1257 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Stop generating transactions | |
| node3 | 2m 5.216s | 2025-09-22 11:28:45.468 | 1258 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | node 3 sent ENTER_VALIDATION Message | |
| node3 | 2m 5.219s | 2025-09-22 11:28:45.471 | 1259 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 finished generating all transactions. | |
| node1 | 2m 6.024s | 2025-09-22 11:28:46.276 | 1259 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 6.025s | 2025-09-22 11:28:46.277 | 1260 | INFO | DEMO_INFO | <<app: appMain 1>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node1 | 2m 6.026s | 2025-09-22 11:28:46.278 | 1261 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Stop generating transactions | |
| node1 | 2m 6.026s | 2025-09-22 11:28:46.278 | 1262 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | node 1 sent ENTER_VALIDATION Message | |
| node1 | 2m 6.030s | 2025-09-22 11:28:46.282 | 1263 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 finished generating all transactions. | |
| node2 | 2m 6.283s | 2025-09-22 11:28:46.535 | 1259 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 2m 6.334s | 2025-09-22 11:28:46.586 | 1260 | INFO | DEMO_INFO | <<app: appMain 2>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node2 | 2m 6.335s | 2025-09-22 11:28:46.587 | 1261 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Stop generating transactions | |
| node2 | 2m 6.335s | 2025-09-22 11:28:46.587 | 1262 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | node 2 sent ENTER_VALIDATION Message | |
| node2 | 2m 6.337s | 2025-09-22 11:28:46.589 | 1263 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 finished generating all transactions. | |
| node0 | 2m 7.132s | 2025-09-22 11:28:47.384 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.733134Z ] | |
| node0 | 2m 7.133s | 2025-09-22 11:28:47.385 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:45.733134Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.134s | 2025-09-22 11:28:47.386 | 1282 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.737115Z ] | |
| node0 | 2m 7.134s | 2025-09-22 11:28:47.386 | 1283 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:45.737115Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.191s | 2025-09-22 11:28:47.443 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.733134Z ] | |
| node1 | 2m 7.191s | 2025-09-22 11:28:47.443 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:45.733134Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.192s | 2025-09-22 11:28:47.444 | 1282 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.737115Z ] | |
| node1 | 2m 7.193s | 2025-09-22 11:28:47.445 | 1283 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:45.737115Z,type=ENTER_VALIDATION] | |
| node2 | 2m 7.262s | 2025-09-22 11:28:47.514 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.733134Z ] | |
| node2 | 2m 7.263s | 2025-09-22 11:28:47.515 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:45.733134Z,type=ENTER_VALIDATION] | |
| node2 | 2m 7.264s | 2025-09-22 11:28:47.516 | 1282 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.737115Z ] | |
| node2 | 2m 7.264s | 2025-09-22 11:28:47.516 | 1283 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:45.737115Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.376s | 2025-09-22 11:28:47.628 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.733134Z ] | |
| node3 | 2m 7.377s | 2025-09-22 11:28:47.629 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:45.733134Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.378s | 2025-09-22 11:28:47.630 | 1282 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:45.737115Z ] | |
| node3 | 2m 7.378s | 2025-09-22 11:28:47.630 | 1283 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:45.737115Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.740s | 2025-09-22 11:28:47.992 | 1284 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:46.646064656Z ] | |
| node1 | 2m 7.741s | 2025-09-22 11:28:47.993 | 1285 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:46.646064656Z,type=ENTER_VALIDATION] | |
| node2 | 2m 7.753s | 2025-09-22 11:28:48.005 | 1284 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:46.646064656Z ] | |
| node2 | 2m 7.754s | 2025-09-22 11:28:48.006 | 1285 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:46.646064656Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.812s | 2025-09-22 11:28:48.064 | 1284 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:46.646064656Z ] | |
| node3 | 2m 7.813s | 2025-09-22 11:28:48.065 | 1285 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:46.646064656Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.953s | 2025-09-22 11:28:48.205 | 1284 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:46.646064656Z ] | |
| node0 | 2m 7.953s | 2025-09-22 11:28:48.205 | 1285 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:46.646064656Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.539s | 2025-09-22 11:28:48.791 | 1306 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:47.126883074Z ] | |
| node0 | 2m 8.539s | 2025-09-22 11:28:48.791 | 1307 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:47.126883074Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.540s | 2025-09-22 11:28:48.792 | 1308 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = ENTER_VALIDATION, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node0 | 2m 8.542s | 2025-09-22 11:28:48.794 | 1309 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node0 | 2m 8.562s | 2025-09-22 11:28:48.814 | 1310 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 0>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1758540527126_126883074.json.gz | |
| node1 | 2m 8.598s | 2025-09-22 11:28:48.850 | 1290 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 8.598s | 2025-09-22 11:28:48.850 | 1291 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:47.126883074Z,type=ENTER_VALIDATION] | |
| node1 | 2m 8.599s | 2025-09-22 11:28:48.851 | 1292 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = ENTER_VALIDATION, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 8.601s | 2025-09-22 11:28:48.853 | 1293 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 8.622s | 2025-09-22 11:28:48.874 | 1294 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 1>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1758540527126_126883074.json.gz | |
| node2 | 2m 8.718s | 2025-09-22 11:28:48.970 | 1306 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:47.126883074Z ] | |
| node2 | 2m 8.718s | 2025-09-22 11:28:48.970 | 1307 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:47.126883074Z,type=ENTER_VALIDATION] | |
| node2 | 2m 8.719s | 2025-09-22 11:28:48.971 | 1308 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = ENTER_VALIDATION, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node2 | 2m 8.721s | 2025-09-22 11:28:48.973 | 1309 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node2 | 2m 8.740s | 2025-09-22 11:28:48.992 | 1310 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 2>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1758540527126_126883074.json.gz | |
| node3 | 2m 8.783s | 2025-09-22 11:28:49.035 | 1306 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-22T11:28:47.126883074Z ] | |
| node3 | 2m 8.783s | 2025-09-22 11:28:49.035 | 1307 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:47.126883074Z,type=ENTER_VALIDATION] | |
| node3 | 2m 8.784s | 2025-09-22 11:28:49.036 | 1308 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = ENTER_VALIDATION, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node3 | 2m 8.786s | 2025-09-22 11:28:49.038 | 1309 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node3 | 2m 8.804s | 2025-09-22 11:28:49.056 | 1310 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 3>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1758540527126_126883074.json.gz | |
| node0 | 2m 8.857s | 2025-09-22 11:28:49.109 | 1311 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node0 | 2m 8.857s | 2025-09-22 11:28:49.109 | 1312 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 8.920s | 2025-09-22 11:28:49.172 | 1311 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 8.920s | 2025-09-22 11:28:49.172 | 1312 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node2 | 2m 9.038s | 2025-09-22 11:28:49.290 | 1311 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node2 | 2m 9.039s | 2025-09-22 11:28:49.291 | 1312 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node3 | 2m 9.089s | 2025-09-22 11:28:49.341 | 1311 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1758540527126_126883074.json, consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node3 | 2m 9.089s | 2025-09-22 11:28:49.341 | 1312 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:47.126883074Z ] | |
| node1 | 2m 10.427s | 2025-09-22 11:28:50.679 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.466173404Z ] | |
| node1 | 2m 10.428s | 2025-09-22 11:28:50.680 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:49.466173404Z,type=EXIT_VALIDATION] | |
| node1 | 2m 10.428s | 2025-09-22 11:28:50.680 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.564237441Z ] | |
| node1 | 2m 10.428s | 2025-09-22 11:28:50.680 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:49.564237441Z,type=EXIT_VALIDATION] | |
| node2 | 2m 10.499s | 2025-09-22 11:28:50.751 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.466173404Z ] | |
| node2 | 2m 10.500s | 2025-09-22 11:28:50.752 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:49.466173404Z,type=EXIT_VALIDATION] | |
| node2 | 2m 10.500s | 2025-09-22 11:28:50.752 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.564237441Z ] | |
| node2 | 2m 10.500s | 2025-09-22 11:28:50.752 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:49.564237441Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.614s | 2025-09-22 11:28:50.866 | 1333 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.466173404Z ] | |
| node3 | 2m 10.615s | 2025-09-22 11:28:50.867 | 1334 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:49.466173404Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.615s | 2025-09-22 11:28:50.867 | 1335 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.564237441Z ] | |
| node3 | 2m 10.615s | 2025-09-22 11:28:50.867 | 1336 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:49.564237441Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.723s | 2025-09-22 11:28:50.975 | 1333 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.466173404Z ] | |
| node0 | 2m 10.723s | 2025-09-22 11:28:50.975 | 1334 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-22T11:28:49.466173404Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.724s | 2025-09-22 11:28:50.976 | 1335 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.564237441Z ] | |
| node0 | 2m 10.724s | 2025-09-22 11:28:50.976 | 1336 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-22T11:28:49.564237441Z,type=EXIT_VALIDATION] | |
| node3 | 2m 11.050s | 2025-09-22 11:28:51.302 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.636473633Z ] | |
| node3 | 2m 11.051s | 2025-09-22 11:28:51.303 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:49.636473633Z,type=EXIT_VALIDATION] | |
| node3 | 2m 11.052s | 2025-09-22 11:28:51.304 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.693116886Z ] | |
| node3 | 2m 11.052s | 2025-09-22 11:28:51.304 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:49.693116886Z,type=EXIT_VALIDATION] | |
| node3 | 2m 11.052s | 2025-09-22 11:28:51.304 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node3 | 2m 11.053s | 2025-09-22 11:28:51.305 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node3 | 2m 11.054s | 2025-09-22 11:28:51.306 | 1343 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node3 | 2m 11.056s | 2025-09-22 11:28:51.308 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-22T11:28:49.693116886Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node0 | 2m 11.147s | 2025-09-22 11:28:51.399 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.636473633Z ] | |
| node0 | 2m 11.147s | 2025-09-22 11:28:51.399 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:49.636473633Z,type=EXIT_VALIDATION] | |
| node0 | 2m 11.147s | 2025-09-22 11:28:51.399 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.693116886Z ] | |
| node0 | 2m 11.148s | 2025-09-22 11:28:51.400 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:49.693116886Z,type=EXIT_VALIDATION] | |
| node0 | 2m 11.148s | 2025-09-22 11:28:51.400 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node0 | 2m 11.148s | 2025-09-22 11:28:51.400 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node0 | 2m 11.151s | 2025-09-22 11:28:51.403 | 1343 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Sending Freeze Transaction... | |
| node0 | 2m 11.151s | 2025-09-22 11:28:51.403 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Finished Sending Freeze Transaction. | |
| node0 | 2m 11.151s | 2025-09-22 11:28:51.403 | 1345 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node0 | 2m 11.153s | 2025-09-22 11:28:51.405 | 1346 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-22T11:28:49.693116886Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 11.405s | 2025-09-22 11:28:51.657 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.636473633Z ] | |
| node1 | 2m 11.405s | 2025-09-22 11:28:51.657 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:49.636473633Z,type=EXIT_VALIDATION] | |
| node1 | 2m 11.405s | 2025-09-22 11:28:51.657 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.693116886Z ] | |
| node1 | 2m 11.406s | 2025-09-22 11:28:51.658 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:49.693116886Z,type=EXIT_VALIDATION] | |
| node1 | 2m 11.406s | 2025-09-22 11:28:51.658 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node1 | 2m 11.406s | 2025-09-22 11:28:51.658 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node1 | 2m 11.407s | 2025-09-22 11:28:51.659 | 1343 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node1 | 2m 11.409s | 2025-09-22 11:28:51.661 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-22T11:28:49.693116886Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 11.535s | 2025-09-22 11:28:51.787 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.636473633Z ] | |
| node2 | 2m 11.536s | 2025-09-22 11:28:51.788 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-22T11:28:49.636473633Z,type=EXIT_VALIDATION] | |
| node2 | 2m 11.536s | 2025-09-22 11:28:51.788 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-22T11:28:49.693116886Z ] | |
| node2 | 2m 11.536s | 2025-09-22 11:28:51.788 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-22T11:28:49.693116886Z,type=EXIT_VALIDATION] | |
| node2 | 2m 11.537s | 2025-09-22 11:28:51.789 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node2 | 2m 11.538s | 2025-09-22 11:28:51.790 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node2 | 2m 11.538s | 2025-09-22 11:28:51.790 | 1343 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node2 | 2m 11.540s | 2025-09-22 11:28:51.792 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-22T11:28:49.693116886Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node3 | 2m 13.449s | 2025-09-22 11:28:53.701 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758540591 | |
| node0 | 2m 13.556s | 2025-09-22 11:28:53.808 | 1367 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758540591 | |
| node1 | 2m 13.668s | 2025-09-22 11:28:53.920 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758540591 | |
| node2 | 2m 13.747s | 2025-09-22 11:28:53.999 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758540591 | |
| node2 | 2m 59.194s | 2025-09-22 11:29:39.446 | 1786 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 2 to 1>> | NetworkUtils: | Connection broken: 2 <- 1 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 2m 59.211s | 2025-09-22 11:29:39.463 | 1787 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 2 to 0>> | NetworkUtils: | Connection broken: 2 <- 0 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 2m 59.219s | 2025-09-22 11:29:39.471 | 1788 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 2 to 3>> | NetworkUtils: | Connection broken: 2 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.470908617Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.470908617Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readInt(DataInputStream.java:385) at org.hiero.base.io.streams.AugmentedDataInputStream.readInt(AugmentedDataInputStream.java:179) at org.hiero.base.io.streams.AugmentedDataInputStream.readBooleanList(AugmentedDataInputStream.java:359) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:159) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node1 | 2m 59.265s | 2025-09-22 11:29:39.517 | 1786 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 1 to 2>> | NetworkUtils: | Connection broken: 1 -> 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 2m 59.285s | 2025-09-22 11:29:39.537 | 1788 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 0 to 2>> | NetworkUtils: | Connection broken: 0 -> 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.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) | |||||||||
| node3 | 2m 59.293s | 2025-09-22 11:29:39.545 | 1786 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 3 to 2>> | NetworkUtils: | Connection broken: 3 <- 2 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.541638343Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.541638343Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:217) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:184) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readEventsINeed$9(SyncUtils.java:272) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 11 more | |||||||||
| node3 | 2m 59.518s | 2025-09-22 11:29:39.770 | 1787 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 3 to 0>> | NetworkUtils: | Connection broken: 3 <- 0 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.770020698Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.770020698Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:137) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:623) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node0 | 2m 59.589s | 2025-09-22 11:29:39.841 | 1789 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 0 to 3>> | NetworkUtils: | Connection broken: 0 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.840805872Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-22T11:29:39.840805872Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readInt(DataInputStream.java:385) at org.hiero.base.io.streams.AugmentedDataInputStream.readInt(AugmentedDataInputStream.java:179) at org.hiero.base.io.streams.AugmentedDataInputStream.readBooleanList(AugmentedDataInputStream.java:359) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:159) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node3 | 2m 59.589s | 2025-09-22 11:29:39.841 | 1788 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 3 to 1>> | NetworkUtils: | Connection broken: 3 <- 1 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 2m 59.660s | 2025-09-22 11:29:39.912 | 1787 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 1 to 3>> | NetworkUtils: | Connection broken: 1 -> 3 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.initiateHeartbeat(HeartbeatPeerProtocol.java:112) at com.swirlds.platform.heartbeats.HeartbeatPeerProtocol.runProtocol(HeartbeatPeerProtocol.java:156) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 3m 4.205s | 2025-09-22 11:29:44.457 | 1789 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node2 | 3m 4.206s | 2025-09-22 11:29:44.458 | 1790 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 3m 4.610s | 2025-09-22 11:29:44.862 | 1788 | INFO | PLATFORM_STATUS | <platformForkJoinThread-5> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node1 | 3m 4.611s | 2025-09-22 11:29:44.863 | 1789 | INFO | STARTUP | <platformForkJoinThread-5> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 4.644s | 2025-09-22 11:29:44.896 | 1789 | INFO | PLATFORM_STATUS | <platformForkJoinThread-7> | DefaultStatusStateMachine: | Platform spent 2.8 m in ACTIVE. Now in CHECKING | |
| node3 | 3m 4.646s | 2025-09-22 11:29:44.898 | 1790 | INFO | STARTUP | <platformForkJoinThread-7> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 4.842s | 2025-09-22 11:29:45.094 | 1790 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node0 | 3m 4.843s | 2025-09-22 11:29:45.095 | 1791 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 41.057s | 2025-09-22 11:30:21.309 | 1791 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node3 | 3m 41.060s | 2025-09-22 11:30:21.312 | 1792 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 3> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 3m 41.062s | 2025-09-22 11:30:21.314 | 1793 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node3 | 3m 41.063s | 2025-09-22 11:30:21.315 | 1794 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node0 | 3m 41.153s | 2025-09-22 11:30:21.405 | 1792 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node0 | 3m 41.155s | 2025-09-22 11:30:21.407 | 1793 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 0> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 3m 41.157s | 2025-09-22 11:30:21.409 | 1794 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node0 | 3m 41.158s | 2025-09-22 11:30:21.410 | 1795 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node1 | 3m 41.409s | 2025-09-22 11:30:21.661 | 1790 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node1 | 3m 41.411s | 2025-09-22 11:30:21.663 | 1791 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 1> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 3m 41.413s | 2025-09-22 11:30:21.665 | 1792 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node1 | 3m 41.414s | 2025-09-22 11:30:21.666 | 1793 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node2 | 3m 41.540s | 2025-09-22 11:30:21.792 | 1791 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-22T11:28:49.693116886Z ] | |
| node2 | 3m 41.542s | 2025-09-22 11:30:21.794 | 1792 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 2> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 3m 41.544s | 2025-09-22 11:30:21.796 | 1793 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node2 | 3m 41.545s | 2025-09-22 11:30:21.797 | 1794 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |