| node2 | 0.000ns | 2025-10-14 11:17:36.940 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node0 | 68.000ms | 2025-10-14 11:17:37.008 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 85.000ms | 2025-10-14 11:17:37.025 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 100.000ms | 2025-10-14 11:17:37.040 | 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 | 101.000ms | 2025-10-14 11:17:37.041 | 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 | 142.000ms | 2025-10-14 11:17:37.082 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node0 | 156.000ms | 2025-10-14 11:17:37.096 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 172.000ms | 2025-10-14 11:17:37.112 | 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 | 173.000ms | 2025-10-14 11:17:37.113 | 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 | 210.000ms | 2025-10-14 11:17:37.150 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [2] are set to run locally | |
| node2 | 217.000ms | 2025-10-14 11:17:37.157 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 230.000ms | 2025-10-14 11:17:37.170 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 245.000ms | 2025-10-14 11:17:37.185 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 246.000ms | 2025-10-14 11:17:37.186 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 247.000ms | 2025-10-14 11:17:37.187 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 247.000ms | 2025-10-14 11:17:37.187 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 247.000ms | 2025-10-14 11:17:37.187 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 247.000ms | 2025-10-14 11:17:37.187 | 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 | 248.000ms | 2025-10-14 11:17:37.188 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 248.000ms | 2025-10-14 11:17:37.188 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 248.000ms | 2025-10-14 11:17:37.188 | 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 | 249.000ms | 2025-10-14 11:17:37.189 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 249.000ms | 2025-10-14 11:17:37.189 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 250.000ms | 2025-10-14 11:17:37.190 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 250.000ms | 2025-10-14 11:17:37.190 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 250.000ms | 2025-10-14 11:17:37.190 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 251.000ms | 2025-10-14 11:17:37.191 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 251.000ms | 2025-10-14 11:17:37.191 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 252.000ms | 2025-10-14 11:17:37.192 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node0 | 286.000ms | 2025-10-14 11:17:37.226 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [0] are set to run locally | |
| node0 | 294.000ms | 2025-10-14 11:17:37.234 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node0 | 322.000ms | 2025-10-14 11:17:37.262 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 325.000ms | 2025-10-14 11:17:37.265 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 325.000ms | 2025-10-14 11:17:37.265 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 326.000ms | 2025-10-14 11:17:37.266 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 326.000ms | 2025-10-14 11:17:37.266 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 327.000ms | 2025-10-14 11:17:37.267 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 327.000ms | 2025-10-14 11:17:37.267 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 328.000ms | 2025-10-14 11:17:37.268 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 328.000ms | 2025-10-14 11:17:37.268 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 329.000ms | 2025-10-14 11:17:37.269 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 329.000ms | 2025-10-14 11:17:37.269 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 330.000ms | 2025-10-14 11:17:37.270 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 330.000ms | 2025-10-14 11:17:37.270 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 331.000ms | 2025-10-14 11:17:37.271 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 331.000ms | 2025-10-14 11:17:37.271 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 366.000ms | 2025-10-14 11:17:37.306 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [3] are set to run locally | |
| node3 | 374.000ms | 2025-10-14 11:17:37.314 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 404.000ms | 2025-10-14 11:17:37.344 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 405.000ms | 2025-10-14 11:17:37.345 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 406.000ms | 2025-10-14 11:17:37.346 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 406.000ms | 2025-10-14 11:17:37.346 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 407.000ms | 2025-10-14 11:17:37.347 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 407.000ms | 2025-10-14 11:17:37.347 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 408.000ms | 2025-10-14 11:17:37.348 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 409.000ms | 2025-10-14 11:17:37.349 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 409.000ms | 2025-10-14 11:17:37.349 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 409.000ms | 2025-10-14 11:17:37.349 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 410.000ms | 2025-10-14 11:17:37.350 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 410.000ms | 2025-10-14 11:17:37.350 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 411.000ms | 2025-10-14 11:17:37.351 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 411.000ms | 2025-10-14 11:17:37.351 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 412.000ms | 2025-10-14 11:17:37.352 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 650.000ms | 2025-10-14 11:17:37.590 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node0 | 740.000ms | 2025-10-14 11:17:37.680 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 827.000ms | 2025-10-14 11:17:37.767 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 1.396s | 2025-10-14 11:17:38.336 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 745ms | |
| node2 | 1.408s | 2025-10-14 11:17:38.348 | 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 | 1.408s | 2025-10-14 11:17:38.348 | 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 | 1.443s | 2025-10-14 11:17:38.383 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node2 | 1.503s | 2025-10-14 11:17:38.443 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node2 | 1.504s | 2025-10-14 11:17:38.444 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node0 | 1.664s | 2025-10-14 11:17:38.604 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 924ms | |
| node0 | 1.678s | 2025-10-14 11:17:38.618 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 1.678s | 2025-10-14 11:17:38.618 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 1.717s | 2025-10-14 11:17:38.657 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node0 | 1.777s | 2025-10-14 11:17:38.717 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node0 | 1.777s | 2025-10-14 11:17:38.717 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node3 | 1.898s | 2025-10-14 11:17:38.838 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1070ms | |
| node3 | 1.909s | 2025-10-14 11:17:38.849 | 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.910s | 2025-10-14 11:17:38.850 | 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.945s | 2025-10-14 11:17:38.885 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 2.013s | 2025-10-14 11:17:38.953 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node3 | 2.014s | 2025-10-14 11:17:38.954 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 3.165s | 2025-10-14 11:17:40.105 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node1 | 3.269s | 2025-10-14 11:17:40.209 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node1 | 3.289s | 2025-10-14 11:17:40.229 | 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 | 3.291s | 2025-10-14 11:17:40.231 | 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 | 3.420s | 2025-10-14 11:17:40.360 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [1] are set to run locally | |
| node1 | 3.429s | 2025-10-14 11:17:40.369 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node1 | 3.462s | 2025-10-14 11:17:40.402 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 3.463s | 2025-10-14 11:17:40.403 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 3.464s | 2025-10-14 11:17:40.404 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.464s | 2025-10-14 11:17:40.404 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 3.465s | 2025-10-14 11:17:40.405 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.465s | 2025-10-14 11:17:40.405 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 3.466s | 2025-10-14 11:17:40.406 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.468s | 2025-10-14 11:17:40.408 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 3.469s | 2025-10-14 11:17:40.409 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 3.469s | 2025-10-14 11:17:40.409 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.470s | 2025-10-14 11:17:40.410 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 3.470s | 2025-10-14 11:17:40.410 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.471s | 2025-10-14 11:17:40.411 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 3.472s | 2025-10-14 11:17:40.412 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.472s | 2025-10-14 11:17:40.412 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 3.516s | 2025-10-14 11:17:40.456 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node2 | 3.590s | 2025-10-14 11:17:40.530 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node2 | 3.591s | 2025-10-14 11:17:40.531 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 3.591s | 2025-10-14 11:17:40.531 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 3.592s | 2025-10-14 11:17:40.532 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 3.592s | 2025-10-14 11:17:40.532 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 3.592s | 2025-10-14 11:17:40.532 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 3.592s | 2025-10-14 11:17:40.532 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 3.593s | 2025-10-14 11:17:40.533 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 3.782s | 2025-10-14 11:17:40.722 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node0 | 3.858s | 2025-10-14 11:17:40.798 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node0 | 3.859s | 2025-10-14 11:17:40.799 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 3.859s | 2025-10-14 11:17:40.799 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 3.860s | 2025-10-14 11:17:40.800 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 3.860s | 2025-10-14 11:17:40.800 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 3.860s | 2025-10-14 11:17:40.800 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 3.860s | 2025-10-14 11:17:40.800 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 3.861s | 2025-10-14 11:17:40.801 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 3.927s | 2025-10-14 11:17:40.867 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 4.067s | 2025-10-14 11:17:41.007 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 4.145s | 2025-10-14 11:17:41.085 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node3 | 4.146s | 2025-10-14 11:17:41.086 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 4.146s | 2025-10-14 11:17:41.086 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 4.147s | 2025-10-14 11:17:41.087 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.147s | 2025-10-14 11:17:41.087 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 4.147s | 2025-10-14 11:17:41.087 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.148s | 2025-10-14 11:17:41.088 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 4.148s | 2025-10-14 11:17:41.088 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.344s | 2025-10-14 11:17:41.284 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node2 | 4.349s | 2025-10-14 11:17:41.289 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 4.633s | 2025-10-14 11:17:41.573 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node0 | 4.638s | 2025-10-14 11:17:41.578 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node3 | 4.973s | 2025-10-14 11:17:41.913 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node3 | 4.979s | 2025-10-14 11:17:41.919 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node1 | 5.224s | 2025-10-14 11:17:42.164 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1295ms | |
| node1 | 5.237s | 2025-10-14 11:17:42.177 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 5.237s | 2025-10-14 11:17:42.177 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 5.275s | 2025-10-14 11:17:42.215 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 5.339s | 2025-10-14 11:17:42.279 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node1 | 5.340s | 2025-10-14 11:17:42.280 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 5.464s | 2025-10-14 11:17:42.404 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26290326] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=154190, randomLong=-3919592972179408758, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11960, randomLong=3295249024729908058, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=958390, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms) | |||||||||
| node2 | 5.494s | 2025-10-14 11:17:42.434 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node2 | 5.502s | 2025-10-14 11:17:42.442 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node2 | 5.507s | 2025-10-14 11:17:42.447 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node2 | 5.586s | 2025-10-14 11:17:42.526 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "13125000000", "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": "IoQ9PA==", "port": 30124 }, { "ipAddressV4": "CoAASg==", "port": 30124 }] }, { "nodeId": "1", "weight": "11875000000", "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": "IoREUg==", "port": 30125 }, { "ipAddressV4": "CoAAFA==", "port": 30125 }] }, { "nodeId": "2", "weight": "12750000000", "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": "iHOnvg==", "port": 30126 }, { "ipAddressV4": "CoAASA==", "port": 30126 }] }, { "nodeId": "3", "weight": "12250000000", "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": "aMa64g==", "port": 30127 }, { "ipAddressV4": "CoAASw==", "port": 30127 }] }] } | |||||||||
| node2 | 5.687s | 2025-10-14 11:17:42.627 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node2 | 5.687s | 2025-10-14 11:17:42.627 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node2 | 5.704s | 2025-10-14 11:17:42.644 | 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: bdf8a81e442f6b72e20f3fd0420ca0b41adfa51a0045949d37c6d33a817f73a59b3717d66c52a27d14dcdaab69bedc69 (root) PlatformTestingToolState / donate-wisdom-magnet-hour 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 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 | 5.754s | 2025-10-14 11:17:42.694 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26258078] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=261990, randomLong=3642728630046285709, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=28080, randomLong=-2515513776523841249, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1458130, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms) | |||||||||
| node0 | 5.783s | 2025-10-14 11:17:42.723 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node0 | 5.791s | 2025-10-14 11:17:42.731 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node0 | 5.796s | 2025-10-14 11:17:42.736 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node0 | 5.876s | 2025-10-14 11:17:42.816 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "13125000000", "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": "IoQ9PA==", "port": 30124 }, { "ipAddressV4": "CoAASg==", "port": 30124 }] }, { "nodeId": "1", "weight": "11875000000", "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": "IoREUg==", "port": 30125 }, { "ipAddressV4": "CoAAFA==", "port": 30125 }] }, { "nodeId": "2", "weight": "12750000000", "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": "iHOnvg==", "port": 30126 }, { "ipAddressV4": "CoAASA==", "port": 30126 }] }, { "nodeId": "3", "weight": "12250000000", "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": "aMa64g==", "port": 30127 }, { "ipAddressV4": "CoAASw==", "port": 30127 }] }] } | |||||||||
| node2 | 5.898s | 2025-10-14 11:17:42.838 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node2 | 5.902s | 2025-10-14 11:17:42.842 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node2 | 5.910s | 2025-10-14 11:17:42.850 | 64 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node2 | 5.911s | 2025-10-14 11:17:42.851 | 65 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 5.912s | 2025-10-14 11:17:42.852 | 66 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node2 | 5.912s | 2025-10-14 11:17:42.852 | 67 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node2 | 5.912s | 2025-10-14 11:17:42.852 | 68 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node2 | 5.913s | 2025-10-14 11:17:42.853 | 69 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node2 | 5.913s | 2025-10-14 11:17:42.853 | 70 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node2 | 5.913s | 2025-10-14 11:17:42.853 | 71 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node2 | 5.914s | 2025-10-14 11:17:42.854 | 72 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 5.914s | 2025-10-14 11:17:42.854 | 73 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node2 | 5.914s | 2025-10-14 11:17:42.854 | 74 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 5.914s | 2025-10-14 11:17:42.854 | 75 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node2 | 5.915s | 2025-10-14 11:17:42.855 | 76 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node2 | 5.915s | 2025-10-14 11:17:42.855 | 77 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node2 | 5.915s | 2025-10-14 11:17:42.855 | 78 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node2 | 5.935s | 2025-10-14 11:17:42.875 | 79 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | insertSeq = true | |
| node2 | 5.936s | 2025-10-14 11:17:42.876 | 80 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | appendSig = true | |
| node2 | 5.936s | 2025-10-14 11:17:42.876 | 81 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | variedSize = false | |
| node2 | 5.936s | 2025-10-14 11:17:42.876 | 82 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | payloadByteSize = 100 | |
| node2 | 5.937s | 2025-10-14 11:17:42.877 | 83 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | maxByteSize = 100 | |
| node2 | 5.937s | 2025-10-14 11:17:42.877 | 84 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node2 | 5.938s | 2025-10-14 11:17:42.878 | 85 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node2 | 5.939s | 2025-10-14 11:17:42.879 | 86 | INFO | DEMO_INFO | <<start-node-2>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node2 | 5.945s | 2025-10-14 11:17:42.885 | 87 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@a270ccb | |
| node2 | 5.946s | 2025-10-14 11:17:42.886 | 88 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 5.946s | 2025-10-14 11:17:42.886 | 89 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 5.954s | 2025-10-14 11:17:42.894 | 94 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@62f17495, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@238e87d6,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@436c7902,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@8d7e865,snapshotInProgress=false] | |
| node2 | 5.962s | 2025-10-14 11:17:42.902 | 95 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node2 | 5.963s | 2025-10-14 11:17:42.903 | 96 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node2 | 5.967s | 2025-10-14 11:17:42.907 | 97 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 3673474862560298333 | |
| node2 | 5.968s | 2025-10-14 11:17:42.908 | 98 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 5.974s | 2025-10-14 11:17:42.914 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node0 | 5.975s | 2025-10-14 11:17:42.915 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node0 | 5.991s | 2025-10-14 11:17:42.931 | 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: bdf8a81e442f6b72e20f3fd0420ca0b41adfa51a0045949d37c6d33a817f73a59b3717d66c52a27d14dcdaab69bedc69 (root) PlatformTestingToolState / donate-wisdom-magnet-hour 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node2 | 6.047s | 2025-10-14 11:17:42.987 | 99 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | Starting platform 2 | |
| node2 | 6.049s | 2025-10-14 11:17:42.989 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node2 | 6.052s | 2025-10-14 11:17:42.992 | 101 | INFO | STARTUP | <<start-node-2>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node2 | 6.053s | 2025-10-14 11:17:42.993 | 102 | INFO | STARTUP | <<start-node-2>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node2 | 6.054s | 2025-10-14 11:17:42.994 | 103 | INFO | STARTUP | <<start-node-2>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 6.056s | 2025-10-14 11:17:42.996 | 104 | WARN | STARTUP | <<start-node-2>> | PcesFileTracker: | No preconsensus event files available | |
| node2 | 6.056s | 2025-10-14 11:17:42.996 | 105 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node2 | 6.057s | 2025-10-14 11:17:42.997 | 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 | 6.058s | 2025-10-14 11:17:42.998 | 107 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 starts transactions ........ | |
| node2 | 6.059s | 2025-10-14 11:17:42.999 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 302.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node2 | 6.059s | 2025-10-14 11:17:42.999 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node2 | 6.063s | 2025-10-14 11:17:43.003 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node2 | 6.063s | 2025-10-14 11:17:43.003 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node3 | 6.101s | 2025-10-14 11:17:43.041 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26352982] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=240830, randomLong=9130889935187179304, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11510, randomLong=-7212611649600401575, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1074200, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node3 | 6.130s | 2025-10-14 11:17:43.070 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 6.140s | 2025-10-14 11:17:43.080 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node3 | 6.146s | 2025-10-14 11:17:43.086 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node0 | 6.194s | 2025-10-14 11:17:43.134 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node0 | 6.198s | 2025-10-14 11:17:43.138 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node0 | 6.206s | 2025-10-14 11:17:43.146 | 64 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node0 | 6.207s | 2025-10-14 11:17:43.147 | 65 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node0 | 6.208s | 2025-10-14 11:17:43.148 | 66 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node0 | 6.208s | 2025-10-14 11:17:43.148 | 67 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node0 | 6.208s | 2025-10-14 11:17:43.148 | 68 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node0 | 6.209s | 2025-10-14 11:17:43.149 | 69 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node0 | 6.209s | 2025-10-14 11:17:43.149 | 70 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node0 | 6.209s | 2025-10-14 11:17:43.149 | 71 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node0 | 6.210s | 2025-10-14 11:17:43.150 | 72 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node0 | 6.210s | 2025-10-14 11:17:43.150 | 73 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node0 | 6.211s | 2025-10-14 11:17:43.151 | 74 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node0 | 6.211s | 2025-10-14 11:17:43.151 | 75 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node0 | 6.211s | 2025-10-14 11:17:43.151 | 76 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node0 | 6.212s | 2025-10-14 11:17:43.152 | 77 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node0 | 6.212s | 2025-10-14 11:17:43.152 | 78 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 6.227s | 2025-10-14 11:17:43.167 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "13125000000", "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": "IoQ9PA==", "port": 30124 }, { "ipAddressV4": "CoAASg==", "port": 30124 }] }, { "nodeId": "1", "weight": "11875000000", "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": "IoREUg==", "port": 30125 }, { "ipAddressV4": "CoAAFA==", "port": 30125 }] }, { "nodeId": "2", "weight": "12750000000", "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": "iHOnvg==", "port": 30126 }, { "ipAddressV4": "CoAASA==", "port": 30126 }] }, { "nodeId": "3", "weight": "12250000000", "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": "aMa64g==", "port": 30127 }, { "ipAddressV4": "CoAASw==", "port": 30127 }] }] } | |||||||||
| node0 | 6.232s | 2025-10-14 11:17:43.172 | 79 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | insertSeq = true | |
| node0 | 6.233s | 2025-10-14 11:17:43.173 | 80 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | appendSig = true | |
| node0 | 6.233s | 2025-10-14 11:17:43.173 | 81 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | variedSize = false | |
| node0 | 6.234s | 2025-10-14 11:17:43.174 | 82 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | payloadByteSize = 100 | |
| node0 | 6.234s | 2025-10-14 11:17:43.174 | 83 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | maxByteSize = 100 | |
| node0 | 6.235s | 2025-10-14 11:17:43.175 | 84 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 6.236s | 2025-10-14 11:17:43.176 | 85 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 6.238s | 2025-10-14 11:17:43.178 | 86 | INFO | DEMO_INFO | <<start-node-0>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 6.244s | 2025-10-14 11:17:43.184 | 87 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@18a12835 | |
| node0 | 6.246s | 2025-10-14 11:17:43.186 | 88 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node0 | 6.246s | 2025-10-14 11:17:43.186 | 89 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node0 | 6.254s | 2025-10-14 11:17:43.194 | 94 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@5f027e38, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2bc4cbf6,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@67318e88,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4857a169,snapshotInProgress=false] | |
| node0 | 6.264s | 2025-10-14 11:17:43.204 | 95 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node0 | 6.264s | 2025-10-14 11:17:43.204 | 96 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 6.269s | 2025-10-14 11:17:43.209 | 97 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 4937702710088638176 | |
| node0 | 6.270s | 2025-10-14 11:17:43.210 | 98 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node3 | 6.328s | 2025-10-14 11:17:43.268 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node3 | 6.328s | 2025-10-14 11:17:43.268 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node3 | 6.344s | 2025-10-14 11:17:43.284 | 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: bdf8a81e442f6b72e20f3fd0420ca0b41adfa51a0045949d37c6d33a817f73a59b3717d66c52a27d14dcdaab69bedc69 (root) PlatformTestingToolState / donate-wisdom-magnet-hour 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 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.357s | 2025-10-14 11:17:43.297 | 99 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | Starting platform 0 | |
| node0 | 6.358s | 2025-10-14 11:17:43.298 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node0 | 6.362s | 2025-10-14 11:17:43.302 | 101 | INFO | STARTUP | <<start-node-0>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 6.363s | 2025-10-14 11:17:43.303 | 102 | INFO | STARTUP | <<start-node-0>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node0 | 6.364s | 2025-10-14 11:17:43.304 | 103 | INFO | STARTUP | <<start-node-0>> | InputWireChecks: | All input wires have been bound. | |
| node0 | 6.365s | 2025-10-14 11:17:43.305 | 104 | WARN | STARTUP | <<start-node-0>> | PcesFileTracker: | No preconsensus event files available | |
| node0 | 6.366s | 2025-10-14 11:17:43.306 | 105 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node0 | 6.367s | 2025-10-14 11:17:43.307 | 106 | INFO | STARTUP | <<start-node-0>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node0 | 6.368s | 2025-10-14 11:17:43.308 | 107 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 starts transactions ........ | |
| node0 | 6.368s | 2025-10-14 11:17:43.308 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 326.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node0 | 6.369s | 2025-10-14 11:17:43.309 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node0 | 6.373s | 2025-10-14 11:17:43.313 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node0 | 6.373s | 2025-10-14 11:17:43.313 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node3 | 6.539s | 2025-10-14 11:17:43.479 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node3 | 6.544s | 2025-10-14 11:17:43.484 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node3 | 6.553s | 2025-10-14 11:17:43.493 | 64 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node3 | 6.554s | 2025-10-14 11:17:43.494 | 65 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node3 | 6.554s | 2025-10-14 11:17:43.494 | 66 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node3 | 6.555s | 2025-10-14 11:17:43.495 | 67 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node3 | 6.555s | 2025-10-14 11:17:43.495 | 68 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node3 | 6.555s | 2025-10-14 11:17:43.495 | 69 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node3 | 6.556s | 2025-10-14 11:17:43.496 | 70 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node3 | 6.556s | 2025-10-14 11:17:43.496 | 71 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node3 | 6.556s | 2025-10-14 11:17:43.496 | 72 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node3 | 6.556s | 2025-10-14 11:17:43.496 | 73 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node3 | 6.557s | 2025-10-14 11:17:43.497 | 74 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node3 | 6.557s | 2025-10-14 11:17:43.497 | 75 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node3 | 6.557s | 2025-10-14 11:17:43.497 | 76 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node3 | 6.557s | 2025-10-14 11:17:43.497 | 77 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node3 | 6.558s | 2025-10-14 11:17:43.498 | 78 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 6.574s | 2025-10-14 11:17:43.514 | 79 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | insertSeq = true | |
| node3 | 6.575s | 2025-10-14 11:17:43.515 | 80 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | appendSig = true | |
| node3 | 6.575s | 2025-10-14 11:17:43.515 | 81 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | variedSize = false | |
| node3 | 6.576s | 2025-10-14 11:17:43.516 | 82 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | payloadByteSize = 100 | |
| node3 | 6.577s | 2025-10-14 11:17:43.517 | 83 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | maxByteSize = 100 | |
| node3 | 6.577s | 2025-10-14 11:17:43.517 | 84 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node3 | 6.578s | 2025-10-14 11:17:43.518 | 85 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node3 | 6.579s | 2025-10-14 11:17:43.519 | 86 | INFO | DEMO_INFO | <<start-node-3>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 6.584s | 2025-10-14 11:17:43.524 | 87 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@68069ad4 | |
| node3 | 6.585s | 2025-10-14 11:17:43.525 | 88 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node3 | 6.585s | 2025-10-14 11:17:43.525 | 89 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node3 | 6.593s | 2025-10-14 11:17:43.533 | 94 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@41316e45, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1606331b,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@1843d5bc,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1b0546ac,snapshotInProgress=false] | |
| node3 | 6.601s | 2025-10-14 11:17:43.541 | 95 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node3 | 6.601s | 2025-10-14 11:17:43.541 | 96 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node3 | 6.606s | 2025-10-14 11:17:43.546 | 97 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -1690307102610538040 | |
| node3 | 6.606s | 2025-10-14 11:17:43.546 | 98 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node3 | 6.684s | 2025-10-14 11:17:43.624 | 99 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | Starting platform 3 | |
| node3 | 6.686s | 2025-10-14 11:17:43.626 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node3 | 6.689s | 2025-10-14 11:17:43.629 | 101 | INFO | STARTUP | <<start-node-3>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node3 | 6.690s | 2025-10-14 11:17:43.630 | 102 | INFO | STARTUP | <<start-node-3>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node3 | 6.691s | 2025-10-14 11:17:43.631 | 103 | INFO | STARTUP | <<start-node-3>> | InputWireChecks: | All input wires have been bound. | |
| node3 | 6.692s | 2025-10-14 11:17:43.632 | 104 | WARN | STARTUP | <<start-node-3>> | PcesFileTracker: | No preconsensus event files available | |
| node3 | 6.693s | 2025-10-14 11:17:43.633 | 105 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node3 | 6.694s | 2025-10-14 11:17:43.634 | 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.695s | 2025-10-14 11:17:43.635 | 107 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 starts transactions ........ | |
| node3 | 6.696s | 2025-10-14 11:17:43.636 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 298.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node3 | 6.696s | 2025-10-14 11:17:43.636 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node3 | 6.700s | 2025-10-14 11:17:43.640 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node3 | 6.700s | 2025-10-14 11:17:43.640 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 7.397s | 2025-10-14 11:17:44.337 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node1 | 7.488s | 2025-10-14 11:17:44.428 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node1 | 7.489s | 2025-10-14 11:17:44.429 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 7.489s | 2025-10-14 11:17:44.429 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 7.489s | 2025-10-14 11:17:44.429 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 7.490s | 2025-10-14 11:17:44.430 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 7.490s | 2025-10-14 11:17:44.430 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 7.490s | 2025-10-14 11:17:44.430 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 7.490s | 2025-10-14 11:17:44.430 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 8.295s | 2025-10-14 11:17:45.235 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node1 | 8.302s | 2025-10-14 11:17:45.242 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node2 | 8.919s | 2025-10-14 11:17:45.859 | 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 | 8.922s | 2025-10-14 11:17:45.862 | 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.217s | 2025-10-14 11:17:46.157 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ] | |
| node0 | 9.220s | 2025-10-14 11:17:46.160 | 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.445s | 2025-10-14 11:17:46.385 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26260515] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=214390, randomLong=2108104695728130922, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11160, randomLong=4738325390310304880, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1185091, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node1 | 9.475s | 2025-10-14 11:17:46.415 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node1 | 9.483s | 2025-10-14 11:17:46.423 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node1 | 9.488s | 2025-10-14 11:17:46.428 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node3 | 9.564s | 2025-10-14 11:17:46.504 | 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' ] | |
| node1 | 9.567s | 2025-10-14 11:17:46.507 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "13125000000", "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": "IoQ9PA==", "port": 30124 }, { "ipAddressV4": "CoAASg==", "port": 30124 }] }, { "nodeId": "1", "weight": "11875000000", "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": "IoREUg==", "port": 30125 }, { "ipAddressV4": "CoAAFA==", "port": 30125 }] }, { "nodeId": "2", "weight": "12750000000", "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": "iHOnvg==", "port": 30126 }, { "ipAddressV4": "CoAASA==", "port": 30126 }] }, { "nodeId": "3", "weight": "12250000000", "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": "aMa64g==", "port": 30127 }, { "ipAddressV4": "CoAASw==", "port": 30127 }] }] } | |||||||||
| node3 | 9.568s | 2025-10-14 11:17:46.508 | 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.674s | 2025-10-14 11:17:46.614 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node1 | 9.675s | 2025-10-14 11:17:46.615 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node1 | 9.691s | 2025-10-14 11:17:46.631 | 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: bdf8a81e442f6b72e20f3fd0420ca0b41adfa51a0045949d37c6d33a817f73a59b3717d66c52a27d14dcdaab69bedc69 (root) PlatformTestingToolState / donate-wisdom-magnet-hour 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 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 | 9.905s | 2025-10-14 11:17:46.845 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node1 | 9.910s | 2025-10-14 11:17:46.850 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 9.919s | 2025-10-14 11:17:46.859 | 64 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node1 | 9.919s | 2025-10-14 11:17:46.859 | 65 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node1 | 9.920s | 2025-10-14 11:17:46.860 | 66 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node1 | 9.920s | 2025-10-14 11:17:46.860 | 67 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node1 | 9.921s | 2025-10-14 11:17:46.861 | 68 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node1 | 9.921s | 2025-10-14 11:17:46.861 | 69 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node1 | 9.921s | 2025-10-14 11:17:46.861 | 70 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node1 | 9.922s | 2025-10-14 11:17:46.862 | 71 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node1 | 9.922s | 2025-10-14 11:17:46.862 | 72 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node1 | 9.922s | 2025-10-14 11:17:46.862 | 73 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node1 | 9.923s | 2025-10-14 11:17:46.863 | 74 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node1 | 9.923s | 2025-10-14 11:17:46.863 | 75 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node1 | 9.923s | 2025-10-14 11:17:46.863 | 76 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node1 | 9.923s | 2025-10-14 11:17:46.863 | 77 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node1 | 9.924s | 2025-10-14 11:17:46.864 | 78 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node1 | 9.941s | 2025-10-14 11:17:46.881 | 79 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | insertSeq = true | |
| node1 | 9.942s | 2025-10-14 11:17:46.882 | 80 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | appendSig = true | |
| node1 | 9.942s | 2025-10-14 11:17:46.882 | 81 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | variedSize = false | |
| node1 | 9.942s | 2025-10-14 11:17:46.882 | 82 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | payloadByteSize = 100 | |
| node1 | 9.943s | 2025-10-14 11:17:46.883 | 83 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | maxByteSize = 100 | |
| node1 | 9.943s | 2025-10-14 11:17:46.883 | 84 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node1 | 9.944s | 2025-10-14 11:17:46.884 | 85 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node1 | 9.945s | 2025-10-14 11:17:46.885 | 86 | INFO | DEMO_INFO | <<start-node-1>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node1 | 9.950s | 2025-10-14 11:17:46.890 | 87 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@18a12835 | |
| node1 | 9.951s | 2025-10-14 11:17:46.891 | 88 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node1 | 9.951s | 2025-10-14 11:17:46.891 | 89 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node1 | 9.959s | 2025-10-14 11:17:46.899 | 94 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@5f027e38, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2bc4cbf6,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@67318e88,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4857a169,snapshotInProgress=false] | |
| node1 | 9.968s | 2025-10-14 11:17:46.908 | 95 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node1 | 9.969s | 2025-10-14 11:17:46.909 | 96 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node1 | 9.974s | 2025-10-14 11:17:46.914 | 97 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -1755925857993495809 | |
| node1 | 9.974s | 2025-10-14 11:17:46.914 | 98 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 10.057s | 2025-10-14 11:17:46.997 | 99 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | Starting platform 1 | |
| node1 | 10.059s | 2025-10-14 11:17:46.999 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 10.063s | 2025-10-14 11:17:47.003 | 101 | INFO | STARTUP | <<start-node-1>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 10.064s | 2025-10-14 11:17:47.004 | 102 | INFO | STARTUP | <<start-node-1>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 10.064s | 2025-10-14 11:17:47.004 | 103 | INFO | STARTUP | <<start-node-1>> | InputWireChecks: | All input wires have been bound. | |
| node1 | 10.067s | 2025-10-14 11:17:47.007 | 104 | WARN | STARTUP | <<start-node-1>> | PcesFileTracker: | No preconsensus event files available | |
| node1 | 10.067s | 2025-10-14 11:17:47.007 | 105 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node1 | 10.068s | 2025-10-14 11:17:47.008 | 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 | 10.069s | 2025-10-14 11:17:47.009 | 107 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 starts transactions ........ | |
| node1 | 10.069s | 2025-10-14 11:17:47.009 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 326.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 10.070s | 2025-10-14 11:17:47.010 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node1 | 10.074s | 2025-10-14 11:17:47.014 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node1 | 10.075s | 2025-10-14 11:17:47.015 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 12.928s | 2025-10-14 11:17:49.868 | 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 | 12.930s | 2025-10-14 11:17:49.870 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node2 | 16.155s | 2025-10-14 11:17:53.095 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node2 | 16.156s | 2025-10-14 11:17:53.096 | 115 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 16.465s | 2025-10-14 11:17:53.405 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node0 | 16.466s | 2025-10-14 11:17:53.406 | 115 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 16.792s | 2025-10-14 11:17:53.732 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node3 | 16.792s | 2025-10-14 11:17:53.732 | 115 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 18.333s | 2025-10-14 11:17:55.273 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.385s | 2025-10-14 11:17:55.325 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.385s | 2025-10-14 11:17:55.325 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 2.2 s in CHECKING. Now in ACTIVE | |
| node2 | 18.386s | 2025-10-14 11:17:55.326 | 118 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 18.387s | 2025-10-14 11:17:55.327 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.483s | 2025-10-14 11:17:55.423 | 119 | TRACE | STARTUP | <<app: appMain 2>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0xEE00FAD6D60516EEA4C8F97FD90391363D852EE6BC56C5ECDDC18AFF1D4D7BC9', privateKey ='0xEE00FAD6D60516EEA4C8F97FD90391363D852EE6BC56C5ECDDC18AFF1D4D7BC9', signature = '0x8A64A29994F595194F9B0A0753F4B0DD0D82D649CBCCC5C0EE7337251D4BBA34628D13515F9FA50CE378D1D6DF10188C1BE2EF9CDF2AC6F6199839D097A88E00',message = '0x1A6B0A1B08021002180120A18D0628914E30914E40CBA3A6F5F1AEACFAFA012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' } | |
| node1 | 18.778s | 2025-10-14 11:17:55.718 | 114 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node0 | 19.303s | 2025-10-14 11:17:56.243 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 2.8 s in CHECKING. Now in ACTIVE | |
| node0 | 19.304s | 2025-10-14 11:17:56.244 | 118 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 19.311s | 2025-10-14 11:17:56.251 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-5> | DefaultStatusStateMachine: | Platform spent 2.5 s in CHECKING. Now in ACTIVE | |
| node3 | 19.311s | 2025-10-14 11:17:56.251 | 118 | INFO | STARTUP | <platformForkJoinThread-5> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 19.326s | 2025-10-14 11:17:56.266 | 119 | TRACE | STARTUP | <<app: appMain 3>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x5C9A6A59093E69C2E456F18E40A40AB08A4A2436D9ADF7A52917CA42237E37D3', privateKey ='0x5C9A6A59093E69C2E456F18E40A40AB08A4A2436D9ADF7A52917CA42237E37D3', signature = '0x7832591744386AA9400402EFF2F3DF34B60029C79A4C4393665A4EF3962FC5AB3D33B0E20A467AAA1D419210018711735D8146FCE48F62A82EC2F87C7246CD00',message = '0x12660A1A0803100318A03820A03828A03830A03840BEE79CE0B4F2C6C7663244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' } | |
| node0 | 19.352s | 2025-10-14 11:17:56.292 | 119 | TRACE | STARTUP | <<app: appMain 0>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x1EE8F9B62A8EDF4FE480D9965F53B1DE8EC29448018E826567A1F55E2F1E4DA4', privateKey ='0x1EE8F9B62A8EDF4FE480D9965F53B1DE8EC29448018E826567A1F55E2F1E4DA4', signature = '0x5B90220D0D0D644EFA3F26DFB9581A08813D32389D607A80F92EEDFA3728EB1320518DD6916A2C7991CB8BA1EB3B3492854B23DAE27029390300663E87986400',message = '0x12660A0A40FCD6C9A8CBA2ECD649325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' } | |
| node3 | 19.895s | 2025-10-14 11:17:56.835 | 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 | 20.145s | 2025-10-14 11:17:57.085 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node1 | 20.166s | 2025-10-14 11:17:57.106 | 115 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node1 | 20.167s | 2025-10-14 11:17:57.107 | 116 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 20.187s | 2025-10-14 11:17:57.127 | 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 | |
| node2 | 20.221s | 2025-10-14 11:17:57.161 | 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 | 20.677s | 2025-10-14 11:17:57.617 | 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 | 20.679s | 2025-10-14 11:17:57.619 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 20.685s | 2025-10-14 11:17:57.625 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 | |
| node0 | 20.687s | 2025-10-14 11:17:57.627 | 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 | 20.757s | 2025-10-14 11:17:57.697 | 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 | 20.759s | 2025-10-14 11:17:57.699 | 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 | 20.780s | 2025-10-14 11:17:57.720 | 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/1/123/3 | |
| node1 | 20.782s | 2025-10-14 11:17:57.722 | 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 | 20.952s | 2025-10-14 11:17:57.892 | 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 | 20.953s | 2025-10-14 11:17:57.893 | 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 | 20.955s | 2025-10-14 11:17:57.895 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:17:55.304988Z Next consensus number: 19 Legacy running event hash: b403a809083f6990d53e81d1256a15ba76ebe122745ee885d6271b34144b526a282818c0740fb1c0e268c3ad594005d7 Legacy running event mnemonic: leisure-year-among-craft Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: e45a5d1156e6dda91aa76ea2ffb889c04c93e5546ea79916417914f8657c45d8644bf47d41a808c5f8380ae4c54d0f6e (root) PlatformTestingToolState / inquiry-peasant-system-enough 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 skull-escape-clump-famous 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 20.957s | 2025-10-14 11:17:57.897 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:17:55.304988Z Next consensus number: 19 Legacy running event hash: b403a809083f6990d53e81d1256a15ba76ebe122745ee885d6271b34144b526a282818c0740fb1c0e268c3ad594005d7 Legacy running event mnemonic: leisure-year-among-craft Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: e45a5d1156e6dda91aa76ea2ffb889c04c93e5546ea79916417914f8657c45d8644bf47d41a808c5f8380ae4c54d0f6e (root) PlatformTestingToolState / inquiry-peasant-system-enough 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 skull-escape-clump-famous 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 20.989s | 2025-10-14 11:17:57.929 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/3/2025/10/14/2025-10-14T11+17+53.570718544Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 20.990s | 2025-10-14 11:17:57.930 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/0/2025/10/14/2025-10-14T11+17+53.394902180Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 20.990s | 2025-10-14 11:17:57.930 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/3/2025/10/14/2025-10-14T11+17+53.570718544Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 20.990s | 2025-10-14 11:17:57.930 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 20.991s | 2025-10-14 11:17:57.931 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/0/2025/10/14/2025-10-14T11+17+53.394902180Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 20.991s | 2025-10-14 11:17:57.931 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node3 | 20.991s | 2025-10-14 11:17:57.931 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node0 | 20.992s | 2025-10-14 11:17:57.932 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node3 | 20.997s | 2025-10-14 11:17:57.937 | 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] | |
| node0 | 20.998s | 2025-10-14 11:17:57.938 | 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] | |
| node2 | 21.024s | 2025-10-14 11:17:57.964 | 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 | 21.028s | 2025-10-14 11:17:57.968 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:17:55.304988Z Next consensus number: 19 Legacy running event hash: b403a809083f6990d53e81d1256a15ba76ebe122745ee885d6271b34144b526a282818c0740fb1c0e268c3ad594005d7 Legacy running event mnemonic: leisure-year-among-craft Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: e45a5d1156e6dda91aa76ea2ffb889c04c93e5546ea79916417914f8657c45d8644bf47d41a808c5f8380ae4c54d0f6e (root) PlatformTestingToolState / inquiry-peasant-system-enough 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 skull-escape-clump-famous 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node1 | 21.060s | 2025-10-14 11:17:58.000 | 192 | 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 | 21.064s | 2025-10-14 11:17:58.004 | 193 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:17:55.304988Z Next consensus number: 19 Legacy running event hash: b403a809083f6990d53e81d1256a15ba76ebe122745ee885d6271b34144b526a282818c0740fb1c0e268c3ad594005d7 Legacy running event mnemonic: leisure-year-among-craft Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: e45a5d1156e6dda91aa76ea2ffb889c04c93e5546ea79916417914f8657c45d8644bf47d41a808c5f8380ae4c54d0f6e (root) PlatformTestingToolState / inquiry-peasant-system-enough 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 skull-escape-clump-famous 1 VirtualMap RosterService.ROSTERS /1 thing-party-glare-blame 2 SingletonNode RosterService.ROSTER_STATE /2 advance-unveil-total-edit 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 | 21.066s | 2025-10-14 11:17:58.006 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/2/2025/10/14/2025-10-14T11+17+53.130716135Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 21.067s | 2025-10-14 11:17:58.007 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/2/2025/10/14/2025-10-14T11+17+53.130716135Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 21.067s | 2025-10-14 11:17:58.007 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node2 | 21.068s | 2025-10-14 11:17:58.008 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 21.073s | 2025-10-14 11:17:58.013 | 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] | |
| node1 | 21.097s | 2025-10-14 11:17:58.037 | 194 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/1/2025/10/14/2025-10-14T11+17+53.466035753Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 21.098s | 2025-10-14 11:17:58.038 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/1/2025/10/14/2025-10-14T11+17+53.466035753Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 21.098s | 2025-10-14 11:17:58.038 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node1 | 21.099s | 2025-10-14 11:17:58.039 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 21.104s | 2025-10-14 11:17:58.044 | 198 | 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] | |
| node1 | 22.316s | 2025-10-14 11:17:59.256 | 199 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.1 s in CHECKING. Now in ACTIVE | |
| node1 | 22.317s | 2025-10-14 11:17:59.257 | 200 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node1 | 22.349s | 2025-10-14 11:17:59.289 | 201 | TRACE | STARTUP | <<app: appMain 1>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x0556343EF2473BB651D1F19BC745049F7F9B495FCAA94A0FD8FA80F32B15D956', privateKey ='0x0556343EF2473BB651D1F19BC745049F7F9B495FCAA94A0FD8FA80F32B15D956', signature = '0xD86B63C1616F821EFB6F76451FBC741A227B7AD3685BA998E069D6EDE16756D567B52F7FA510675C64ADEAD8A620BC18AC3AAE920B6EE5E153EE538740F00706',message = '0x12660A1A0801100118E01220E01228E01230E0124081F9E0F0BFB4ABF36A3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038014001' } | |
| node2 | 24.834s | 2025-10-14 11:18:01.774 | 226 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 25.499s | 2025-10-14 11:18:02.439 | 242 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 25.836s | 2025-10-14 11:18:02.776 | 242 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 26.252s | 2025-10-14 11:18:03.192 | 243 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 27.019s | 2025-10-14 11:18:03.959 | 263 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 27.760s | 2025-10-14 11:18:04.700 | 263 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 28.666s | 2025-10-14 11:18:05.606 | 266 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 30.392s | 2025-10-14 11:18:07.332 | 287 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 58.172s | 2025-10-14 11:18:35.112 | 564 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 58.419s | 2025-10-14 11:18:35.359 | 564 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 59.116s | 2025-10-14 11:18:36.056 | 568 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 1m 1.526s | 2025-10-14 11:18:38.466 | 604 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 1m 22.912s | 2025-10-14 11:18:59.852 | 805 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node2 | 1m 22.913s | 2025-10-14 11:18:59.853 | 806 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node2 | 1m 22.915s | 2025-10-14 11:18:59.855 | 807 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | node2 submits a transaction SAVE_EXPECTED_MAP | |
| node3 | 1m 23.689s | 2025-10-14 11:19:00.629 | 805 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node3 | 1m 23.691s | 2025-10-14 11:19:00.631 | 806 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node3 | 1m 23.692s | 2025-10-14 11:19:00.632 | 807 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | node3 submits a transaction SAVE_EXPECTED_MAP | |
| node0 | 1m 24.433s | 2025-10-14 11:19:01.373 | 809 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 24.546s | 2025-10-14 11:19:01.486 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node0 | 1m 24.613s | 2025-10-14 11:19:01.553 | 810 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node0 | 1m 24.613s | 2025-10-14 11:19:01.553 | 811 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node0 | 1m 24.614s | 2025-10-14 11:19:01.554 | 812 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | node0 submits a transaction SAVE_EXPECTED_MAP | |
| node3 | 1m 24.630s | 2025-10-14 11:19:01.570 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node1 | 1m 24.874s | 2025-10-14 11:19:01.814 | 809 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 25.125s | 2025-10-14 11:19:02.065 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node3 | 1m 25.197s | 2025-10-14 11:19:02.137 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 25.254s | 2025-10-14 11:19:02.194 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 25.306s | 2025-10-14 11:19:02.246 | 826 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node2 | 1m 26.542s | 2025-10-14 11:19:03.482 | 850 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760440742054_54419119.json.gz | |
| node1 | 1m 26.723s | 2025-10-14 11:19:03.663 | 847 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760440742054_54419119.json.gz | |
| node2 | 1m 26.831s | 2025-10-14 11:19:03.771 | 851 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node0 | 1m 27.024s | 2025-10-14 11:19:03.964 | 850 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760440742054_54419119.json.gz | |
| node1 | 1m 27.029s | 2025-10-14 11:19:03.969 | 848 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 27.036s | 2025-10-14 11:19:03.976 | 850 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760440742054_54419119.json.gz | |
| node0 | 1m 27.317s | 2025-10-14 11:19:04.257 | 851 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 27.331s | 2025-10-14 11:19:04.271 | 851 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node1 | 1m 27.676s | 2025-10-14 11:19:04.616 | 853 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node1 | 1m 27.727s | 2025-10-14 11:19:04.667 | 854 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node1 | 1m 27.728s | 2025-10-14 11:19:04.668 | 855 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | node1 submits a transaction SAVE_EXPECTED_MAP | |
| node3 | 1m 29.919s | 2025-10-14 11:19:06.859 | 892 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 30.025s | 2025-10-14 11:19:06.965 | 876 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node0 | 1m 30.058s | 2025-10-14 11:19:06.998 | 892 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 30.189s | 2025-10-14 11:19:07.129 | 892 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 30.228s | 2025-10-14 11:19:07.168 | 893 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 30.363s | 2025-10-14 11:19:07.303 | 893 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 1m 31.254s | 2025-10-14 11:19:08.194 | 893 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 32.027s | 2025-10-14 11:19:08.967 | 914 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 1m 32.092s | 2025-10-14 11:19:09.032 | 914 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 1m 32.915s | 2025-10-14 11:19:09.855 | 914 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 1m 33.044s | 2025-10-14 11:19:09.984 | 913 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 1m 34.561s | 2025-10-14 11:19:11.501 | 934 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 2m 3.620s | 2025-10-14 11:19:40.560 | 1215 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 2m 3.622s | 2025-10-14 11:19:40.562 | 1216 | INFO | DEMO_INFO | <<app: appMain 2>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node2 | 2m 3.623s | 2025-10-14 11:19:40.563 | 1217 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Stop generating transactions | |
| node2 | 2m 3.627s | 2025-10-14 11:19:40.567 | 1218 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | node 2 sent ENTER_VALIDATION Message | |
| node2 | 2m 3.630s | 2025-10-14 11:19:40.570 | 1219 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 finished generating all transactions. | |
| node0 | 2m 3.966s | 2025-10-14 11:19:40.906 | 1215 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 2m 3.969s | 2025-10-14 11:19:40.909 | 1216 | INFO | DEMO_INFO | <<app: appMain 0>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node0 | 2m 3.969s | 2025-10-14 11:19:40.909 | 1217 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Stop generating transactions | |
| node0 | 2m 3.973s | 2025-10-14 11:19:40.913 | 1218 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | node 0 sent ENTER_VALIDATION Message | |
| node0 | 2m 3.976s | 2025-10-14 11:19:40.916 | 1219 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 finished generating all transactions. | |
| node3 | 2m 4.797s | 2025-10-14 11:19:41.737 | 1235 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 2m 4.799s | 2025-10-14 11:19:41.739 | 1236 | INFO | DEMO_INFO | <<app: appMain 3>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node3 | 2m 4.799s | 2025-10-14 11:19:41.739 | 1237 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Stop generating transactions | |
| node3 | 2m 4.799s | 2025-10-14 11:19:41.739 | 1238 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | node 3 sent ENTER_VALIDATION Message | |
| node3 | 2m 4.802s | 2025-10-14 11:19:41.742 | 1239 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 finished generating all transactions. | |
| node2 | 2m 5.228s | 2025-10-14 11:19:42.168 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:40.821185882Z ] | |
| node2 | 2m 5.230s | 2025-10-14 11:19:42.170 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:40.821185882Z,type=ENTER_VALIDATION] | |
| node3 | 2m 5.302s | 2025-10-14 11:19:42.242 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:40.821185882Z ] | |
| node3 | 2m 5.302s | 2025-10-14 11:19:42.242 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:40.821185882Z,type=ENTER_VALIDATION] | |
| node1 | 2m 5.383s | 2025-10-14 11:19:42.323 | 1235 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:40.821185882Z ] | |
| node1 | 2m 5.385s | 2025-10-14 11:19:42.325 | 1236 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:40.821185882Z,type=ENTER_VALIDATION] | |
| node0 | 2m 5.457s | 2025-10-14 11:19:42.397 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:40.821185882Z ] | |
| node0 | 2m 5.459s | 2025-10-14 11:19:42.399 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:40.821185882Z,type=ENTER_VALIDATION] | |
| node1 | 2m 5.948s | 2025-10-14 11:19:42.888 | 1237 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:41.385400291Z ] | |
| node1 | 2m 5.949s | 2025-10-14 11:19:42.889 | 1238 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:41.385400291Z,type=ENTER_VALIDATION] | |
| node2 | 2m 6.054s | 2025-10-14 11:19:42.994 | 1242 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:41.385400291Z ] | |
| node2 | 2m 6.055s | 2025-10-14 11:19:42.995 | 1243 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:41.385400291Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.124s | 2025-10-14 11:19:43.064 | 1242 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:41.385400291Z ] | |
| node0 | 2m 6.125s | 2025-10-14 11:19:43.065 | 1243 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:41.385400291Z,type=ENTER_VALIDATION] | |
| node3 | 2m 6.214s | 2025-10-14 11:19:43.154 | 1242 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:41.385400291Z ] | |
| node3 | 2m 6.214s | 2025-10-14 11:19:43.154 | 1243 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:41.385400291Z,type=ENTER_VALIDATION] | |
| node2 | 2m 6.632s | 2025-10-14 11:19:43.572 | 1248 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:42.094189083Z ] | |
| node2 | 2m 6.633s | 2025-10-14 11:19:43.573 | 1249 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:42.094189083Z,type=ENTER_VALIDATION] | |
| node3 | 2m 6.710s | 2025-10-14 11:19:43.650 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:42.094189083Z ] | |
| node3 | 2m 6.710s | 2025-10-14 11:19:43.650 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:42.094189083Z,type=ENTER_VALIDATION] | |
| node1 | 2m 6.791s | 2025-10-14 11:19:43.731 | 1259 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:42.094189083Z ] | |
| node1 | 2m 6.792s | 2025-10-14 11:19:43.732 | 1260 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:42.094189083Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.864s | 2025-10-14 11:19:43.804 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:42.094189083Z ] | |
| node0 | 2m 6.864s | 2025-10-14 11:19:43.804 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:42.094189083Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.188s | 2025-10-14 11:19:44.128 | 1261 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 7.239s | 2025-10-14 11:19:44.179 | 1262 | INFO | DEMO_INFO | <<app: appMain 1>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node1 | 2m 7.239s | 2025-10-14 11:19:44.179 | 1263 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Stop generating transactions | |
| node1 | 2m 7.240s | 2025-10-14 11:19:44.180 | 1264 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | node 1 sent ENTER_VALIDATION Message | |
| node1 | 2m 7.240s | 2025-10-14 11:19:44.180 | 1265 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 finished generating all transactions. | |
| node2 | 2m 9.450s | 2025-10-14 11:19:46.390 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:44.644146Z ] | |
| node2 | 2m 9.451s | 2025-10-14 11:19:46.391 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:44.644146Z,type=ENTER_VALIDATION] | |
| node2 | 2m 9.452s | 2025-10-14 11:19:46.392 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node2 | 2m 9.454s | 2025-10-14 11:19:46.394 | 1289 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node2 | 2m 9.474s | 2025-10-14 11:19:46.414 | 1290 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 2>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760440784644_644146000.json.gz | |
| node3 | 2m 9.548s | 2025-10-14 11:19:46.488 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:44.644146Z ] | |
| node3 | 2m 9.549s | 2025-10-14 11:19:46.489 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:44.644146Z,type=ENTER_VALIDATION] | |
| node3 | 2m 9.550s | 2025-10-14 11:19:46.490 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node3 | 2m 9.552s | 2025-10-14 11:19:46.492 | 1289 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node3 | 2m 9.572s | 2025-10-14 11:19:46.512 | 1290 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 3>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760440784644_644146000.json.gz | |
| node1 | 2m 9.622s | 2025-10-14 11:19:46.562 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:44.644146Z ] | |
| node1 | 2m 9.623s | 2025-10-14 11:19:46.563 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:44.644146Z,type=ENTER_VALIDATION] | |
| node1 | 2m 9.624s | 2025-10-14 11:19:46.564 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node1 | 2m 9.626s | 2025-10-14 11:19:46.566 | 1289 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node1 | 2m 9.648s | 2025-10-14 11:19:46.588 | 1290 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 1>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760440784644_644146000.json.gz | |
| node0 | 2m 9.681s | 2025-10-14 11:19:46.621 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:19:44.644146Z ] | |
| node0 | 2m 9.681s | 2025-10-14 11:19:46.621 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:44.644146Z,type=ENTER_VALIDATION] | |
| node0 | 2m 9.682s | 2025-10-14 11:19:46.622 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node0 | 2m 9.684s | 2025-10-14 11:19:46.624 | 1289 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node0 | 2m 9.704s | 2025-10-14 11:19:46.644 | 1290 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 0>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760440784644_644146000.json.gz | |
| node2 | 2m 9.775s | 2025-10-14 11:19:46.715 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node2 | 2m 9.776s | 2025-10-14 11:19:46.716 | 1292 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node3 | 2m 9.877s | 2025-10-14 11:19:46.817 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node3 | 2m 9.878s | 2025-10-14 11:19:46.818 | 1292 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node1 | 2m 9.957s | 2025-10-14 11:19:46.897 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node1 | 2m 9.958s | 2025-10-14 11:19:46.898 | 1292 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node0 | 2m 10.007s | 2025-10-14 11:19:46.947 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1760440784644_644146000.json, consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node0 | 2m 10.008s | 2025-10-14 11:19:46.948 | 1292 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:44.644146Z ] | |
| node2 | 2m 12.271s | 2025-10-14 11:19:49.211 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.255732818Z ] | |
| node2 | 2m 12.271s | 2025-10-14 11:19:49.211 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:47.255732818Z,type=EXIT_VALIDATION] | |
| node2 | 2m 12.271s | 2025-10-14 11:19:49.211 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.314268831Z ] | |
| node2 | 2m 12.271s | 2025-10-14 11:19:49.211 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:47.314268831Z,type=EXIT_VALIDATION] | |
| node2 | 2m 12.272s | 2025-10-14 11:19:49.212 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.391818446Z ] | |
| node2 | 2m 12.272s | 2025-10-14 11:19:49.212 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:47.391818446Z,type=EXIT_VALIDATION] | |
| node2 | 2m 12.272s | 2025-10-14 11:19:49.212 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.464590354Z ] | |
| node2 | 2m 12.272s | 2025-10-14 11:19:49.212 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:47.464590354Z,type=EXIT_VALIDATION] | |
| node2 | 2m 12.272s | 2025-10-14 11:19:49.212 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node2 | 2m 12.273s | 2025-10-14 11:19:49.213 | 1323 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node2 | 2m 12.273s | 2025-10-14 11:19:49.213 | 1325 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node2 | 2m 12.277s | 2025-10-14 11:19:49.217 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:19:47.464590354Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node3 | 2m 12.377s | 2025-10-14 11:19:49.317 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.255732818Z ] | |
| node3 | 2m 12.378s | 2025-10-14 11:19:49.318 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:47.255732818Z,type=EXIT_VALIDATION] | |
| node3 | 2m 12.378s | 2025-10-14 11:19:49.318 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.314268831Z ] | |
| node3 | 2m 12.378s | 2025-10-14 11:19:49.318 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:47.314268831Z,type=EXIT_VALIDATION] | |
| node3 | 2m 12.379s | 2025-10-14 11:19:49.319 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.391818446Z ] | |
| node3 | 2m 12.379s | 2025-10-14 11:19:49.319 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:47.391818446Z,type=EXIT_VALIDATION] | |
| node3 | 2m 12.379s | 2025-10-14 11:19:49.319 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.464590354Z ] | |
| node3 | 2m 12.379s | 2025-10-14 11:19:49.319 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:47.464590354Z,type=EXIT_VALIDATION] | |
| node3 | 2m 12.379s | 2025-10-14 11:19:49.319 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node3 | 2m 12.380s | 2025-10-14 11:19:49.320 | 1323 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node3 | 2m 12.380s | 2025-10-14 11:19:49.320 | 1325 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node3 | 2m 12.383s | 2025-10-14 11:19:49.323 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:19:47.464590354Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 12.445s | 2025-10-14 11:19:49.385 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.255732818Z ] | |
| node1 | 2m 12.447s | 2025-10-14 11:19:49.387 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:47.255732818Z,type=EXIT_VALIDATION] | |
| node1 | 2m 12.448s | 2025-10-14 11:19:49.388 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.314268831Z ] | |
| node1 | 2m 12.448s | 2025-10-14 11:19:49.388 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:47.314268831Z,type=EXIT_VALIDATION] | |
| node1 | 2m 12.448s | 2025-10-14 11:19:49.388 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.391818446Z ] | |
| node1 | 2m 12.449s | 2025-10-14 11:19:49.389 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:47.391818446Z,type=EXIT_VALIDATION] | |
| node1 | 2m 12.449s | 2025-10-14 11:19:49.389 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.464590354Z ] | |
| node1 | 2m 12.449s | 2025-10-14 11:19:49.389 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:47.464590354Z,type=EXIT_VALIDATION] | |
| node1 | 2m 12.449s | 2025-10-14 11:19:49.389 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node1 | 2m 12.451s | 2025-10-14 11:19:49.391 | 1322 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node1 | 2m 12.452s | 2025-10-14 11:19:49.392 | 1324 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node1 | 2m 12.455s | 2025-10-14 11:19:49.395 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:19:47.464590354Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node0 | 2m 12.501s | 2025-10-14 11:19:49.441 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.255732818Z ] | |
| node0 | 2m 12.502s | 2025-10-14 11:19:49.442 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:19:47.255732818Z,type=EXIT_VALIDATION] | |
| node0 | 2m 12.502s | 2025-10-14 11:19:49.442 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.314268831Z ] | |
| node0 | 2m 12.502s | 2025-10-14 11:19:49.442 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:19:47.314268831Z,type=EXIT_VALIDATION] | |
| node0 | 2m 12.502s | 2025-10-14 11:19:49.442 | 1317 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.391818446Z ] | |
| node0 | 2m 12.502s | 2025-10-14 11:19:49.442 | 1318 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:19:47.391818446Z,type=EXIT_VALIDATION] | |
| node0 | 2m 12.503s | 2025-10-14 11:19:49.443 | 1319 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:19:47.464590354Z ] | |
| node0 | 2m 12.503s | 2025-10-14 11:19:49.443 | 1320 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:19:47.464590354Z,type=EXIT_VALIDATION] | |
| node0 | 2m 12.503s | 2025-10-14 11:19:49.443 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node0 | 2m 12.504s | 2025-10-14 11:19:49.444 | 1323 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node0 | 2m 12.506s | 2025-10-14 11:19:49.446 | 1327 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Sending Freeze Transaction... | |
| node0 | 2m 12.506s | 2025-10-14 11:19:49.446 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Finished Sending Freeze Transaction. | |
| node0 | 2m 12.506s | 2025-10-14 11:19:49.446 | 1329 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node0 | 2m 12.510s | 2025-10-14 11:19:49.450 | 1330 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:19:47.464590354Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 14.423s | 2025-10-14 11:19:51.363 | 1345 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760440849 | |
| node2 | 2m 14.521s | 2025-10-14 11:19:51.461 | 1345 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760440849 | |
| node0 | 2m 14.601s | 2025-10-14 11:19:51.541 | 1347 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760440849 | |
| node3 | 2m 14.680s | 2025-10-14 11:19:51.620 | 1345 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760440849 | |
| node2 | 2m 59.249s | 2025-10-14 11:20:36.189 | 1726 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 2 to 1>> | NetworkUtils: | Connection broken: 2 <- 1 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.186571442Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:258) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.186571442Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:304) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:113) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:254) ... 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:640) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:146) ... 10 more | |||||||||
| node2 | 2m 59.272s | 2025-10-14 11:20:36.212 | 1727 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 2 to 0>> | NetworkUtils: | Connection broken: 2 <- 0 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.211763781Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:258) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.211763781Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:304) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:241) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:201) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:113) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:254) ... 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:278) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:146) ... 11 more | |||||||||
| node1 | 2m 59.321s | 2025-10-14 11:20:36.261 | 1726 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 1 to 2>> | NetworkUtils: | Connection broken: 1 -> 2 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.257424563Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:258) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.257424563Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:304) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:180) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:113) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:254) ... 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.readBoolean(DataInputStream.java:255) at org.hiero.base.io.streams.AugmentedDataInputStream.readBoolean(AugmentedDataInputStream.java:137) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:163) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:146) ... 10 more | |||||||||
| node2 | 2m 59.322s | 2025-10-14 11:20:36.262 | 1728 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 2 to 3>> | NetworkUtils: | Connection broken: 2 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.262621599Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:258) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.262621599Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:304) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:241) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:201) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:113) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:254) ... 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:278) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:146) ... 11 more | |||||||||
| node0 | 2m 59.346s | 2025-10-14 11:20:36.286 | 1728 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 0 to 2>> | NetworkUtils: | Connection broken: 0 -> 2 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.282673368Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:258) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:20:36.282673368Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:148) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:304) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:241) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:201) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:113) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:254) ... 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:278) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:146) ... 11 more | |||||||||
| node3 | 2m 59.397s | 2025-10-14 11:20:36.337 | 1726 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 3 to 2>> | NetworkUtils: | Connection broken: 3 <- 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.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 59.555s | 2025-10-14 11:20:36.495 | 1727 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 3 to 0>> | NetworkUtils: | Connection broken: 3 <- 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.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) | |||||||||
| node0 | 2m 59.625s | 2025-10-14 11:20:36.565 | 1729 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 0 to 3>> | NetworkUtils: | Connection broken: 0 -> 3 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 59.670s | 2025-10-14 11:20:36.610 | 1728 | 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.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) | |||||||||
| node1 | 2m 59.741s | 2025-10-14 11:20:36.681 | 1727 | 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.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) | |||||||||
| node2 | 3m 4.154s | 2025-10-14 11:20:41.094 | 1729 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 2.8 m in ACTIVE. Now in CHECKING | |
| node2 | 3m 4.155s | 2025-10-14 11:20:41.095 | 1730 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 4.292s | 2025-10-14 11:20:41.232 | 1729 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node3 | 3m 4.292s | 2025-10-14 11:20:41.232 | 1730 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 4.365s | 2025-10-14 11:20:41.305 | 1730 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 2.8 m in ACTIVE. Now in CHECKING | |
| node0 | 3m 4.365s | 2025-10-14 11:20:41.305 | 1731 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 3m 4.666s | 2025-10-14 11:20:41.606 | 1728 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node1 | 3m 4.667s | 2025-10-14 11:20:41.607 | 1729 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 3m 42.278s | 2025-10-14 11:21:19.218 | 1731 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node2 | 3m 42.280s | 2025-10-14 11:21:19.220 | 1732 | 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:1224) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1170) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 3m 42.281s | 2025-10-14 11:21:19.221 | 1733 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node2 | 3m 42.282s | 2025-10-14 11:21:19.222 | 1734 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node3 | 3m 42.383s | 2025-10-14 11:21:19.323 | 1731 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node3 | 3m 42.388s | 2025-10-14 11:21:19.328 | 1732 | 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:1224) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1170) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 3m 42.391s | 2025-10-14 11:21:19.331 | 1733 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node3 | 3m 42.392s | 2025-10-14 11:21:19.332 | 1734 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node1 | 3m 42.456s | 2025-10-14 11:21:19.396 | 1730 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node1 | 3m 42.460s | 2025-10-14 11:21:19.400 | 1731 | 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:1224) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1170) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 3m 42.462s | 2025-10-14 11:21:19.402 | 1732 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node1 | 3m 42.464s | 2025-10-14 11:21:19.404 | 1733 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node0 | 3m 42.511s | 2025-10-14 11:21:19.451 | 1732 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:19:47.464590354Z ] | |
| node0 | 3m 42.515s | 2025-10-14 11:21:19.455 | 1733 | 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:1224) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1170) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 3m 42.517s | 2025-10-14 11:21:19.457 | 1734 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node0 | 3m 42.519s | 2025-10-14 11:21:19.459 | 1735 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |