| node3 | 0.000ns | 2025-10-18 06:56:14.890 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node3 | 92.000ms | 2025-10-18 06:56:14.982 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node3 | 109.000ms | 2025-10-18 06:56:14.999 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 110.000ms | 2025-10-18 06:56:15.000 | 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 | 212.000ms | 2025-10-18 06:56:15.102 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node3 | 224.000ms | 2025-10-18 06:56:15.114 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [3] are set to run locally | |
| node3 | 252.000ms | 2025-10-18 06:56:15.142 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 282.000ms | 2025-10-18 06:56:15.172 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 284.000ms | 2025-10-18 06:56:15.174 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 284.000ms | 2025-10-18 06:56:15.174 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 285.000ms | 2025-10-18 06:56:15.175 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 286.000ms | 2025-10-18 06:56:15.176 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 286.000ms | 2025-10-18 06:56:15.176 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 286.000ms | 2025-10-18 06:56:15.176 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 288.000ms | 2025-10-18 06:56:15.178 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 288.000ms | 2025-10-18 06:56:15.178 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 288.000ms | 2025-10-18 06:56:15.178 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 289.000ms | 2025-10-18 06:56:15.179 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 289.000ms | 2025-10-18 06:56:15.179 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 289.000ms | 2025-10-18 06:56:15.179 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 290.000ms | 2025-10-18 06:56:15.180 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 290.000ms | 2025-10-18 06:56:15.180 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 304.000ms | 2025-10-18 06:56:15.194 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 321.000ms | 2025-10-18 06:56:15.211 | 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 | 322.000ms | 2025-10-18 06:56:15.212 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 353.000ms | 2025-10-18 06:56:15.243 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 439.000ms | 2025-10-18 06:56:15.329 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [2] are set to run locally | |
| node0 | 448.000ms | 2025-10-18 06:56:15.338 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 465.000ms | 2025-10-18 06:56:15.355 | 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 | 466.000ms | 2025-10-18 06:56:15.356 | 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 | 467.000ms | 2025-10-18 06:56:15.357 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node2 | 496.000ms | 2025-10-18 06:56:15.386 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 498.000ms | 2025-10-18 06:56:15.388 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 498.000ms | 2025-10-18 06:56:15.388 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 498.000ms | 2025-10-18 06:56:15.388 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 499.000ms | 2025-10-18 06:56:15.389 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 499.000ms | 2025-10-18 06:56:15.389 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 500.000ms | 2025-10-18 06:56:15.390 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 501.000ms | 2025-10-18 06:56:15.391 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 501.000ms | 2025-10-18 06:56:15.391 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 501.000ms | 2025-10-18 06:56:15.391 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 502.000ms | 2025-10-18 06:56:15.392 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 502.000ms | 2025-10-18 06:56:15.392 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 502.000ms | 2025-10-18 06:56:15.392 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 503.000ms | 2025-10-18 06:56:15.393 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 504.000ms | 2025-10-18 06:56:15.394 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node0 | 581.000ms | 2025-10-18 06:56:15.471 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [0] are set to run locally | |
| node0 | 610.000ms | 2025-10-18 06:56:15.500 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node0 | 641.000ms | 2025-10-18 06:56:15.531 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 643.000ms | 2025-10-18 06:56:15.533 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 643.000ms | 2025-10-18 06:56:15.533 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 643.000ms | 2025-10-18 06:56:15.533 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 644.000ms | 2025-10-18 06:56:15.534 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 644.000ms | 2025-10-18 06:56:15.534 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 645.000ms | 2025-10-18 06:56:15.535 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 646.000ms | 2025-10-18 06:56:15.536 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 646.000ms | 2025-10-18 06:56:15.536 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 646.000ms | 2025-10-18 06:56:15.536 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 647.000ms | 2025-10-18 06:56:15.537 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 647.000ms | 2025-10-18 06:56:15.537 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 648.000ms | 2025-10-18 06:56:15.538 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 648.000ms | 2025-10-18 06:56:15.538 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 649.000ms | 2025-10-18 06:56:15.539 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 701.000ms | 2025-10-18 06:56:15.591 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 933.000ms | 2025-10-18 06:56:15.823 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node0 | 1.067s | 2025-10-18 06:56:15.957 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 1.617s | 2025-10-18 06:56:16.507 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 915ms | |
| node3 | 1.630s | 2025-10-18 06:56:16.520 | 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.630s | 2025-10-18 06:56:16.520 | 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.669s | 2025-10-18 06:56:16.559 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 1.727s | 2025-10-18 06:56:16.617 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node3 | 1.728s | 2025-10-18 06:56:16.618 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 2.038s | 2025-10-18 06:56:16.928 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1104ms | |
| node2 | 2.054s | 2025-10-18 06:56:16.944 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 2.054s | 2025-10-18 06:56:16.944 | 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 | 2.096s | 2025-10-18 06:56:16.986 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 2.097s | 2025-10-18 06:56:16.987 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node0 | 2.156s | 2025-10-18 06:56:17.046 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1088ms | |
| node2 | 2.160s | 2025-10-18 06:56:17.050 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node2 | 2.161s | 2025-10-18 06:56:17.051 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node0 | 2.171s | 2025-10-18 06:56:17.061 | 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 | 2.171s | 2025-10-18 06:56:17.061 | 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 | 2.207s | 2025-10-18 06:56:17.097 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 2.212s | 2025-10-18 06:56:17.102 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 2.227s | 2025-10-18 06:56:17.117 | 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 | 2.228s | 2025-10-18 06:56:17.118 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 2.274s | 2025-10-18 06:56:17.164 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node0 | 2.274s | 2025-10-18 06:56:17.164 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 2.370s | 2025-10-18 06:56:17.260 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [1] are set to run locally | |
| node1 | 2.405s | 2025-10-18 06:56:17.295 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node1 | 2.443s | 2025-10-18 06:56:17.333 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 2.445s | 2025-10-18 06:56:17.335 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 2.445s | 2025-10-18 06:56:17.335 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.446s | 2025-10-18 06:56:17.336 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 2.446s | 2025-10-18 06:56:17.336 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.447s | 2025-10-18 06:56:17.337 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 2.447s | 2025-10-18 06:56:17.337 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.449s | 2025-10-18 06:56:17.339 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 2.449s | 2025-10-18 06:56:17.339 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 2.449s | 2025-10-18 06:56:17.339 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.450s | 2025-10-18 06:56:17.340 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 2.450s | 2025-10-18 06:56:17.340 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.451s | 2025-10-18 06:56:17.341 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 2.451s | 2025-10-18 06:56:17.341 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 2.452s | 2025-10-18 06:56:17.342 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node1 | 2.947s | 2025-10-18 06:56:17.837 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 3.716s | 2025-10-18 06:56:18.606 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 3.796s | 2025-10-18 06:56:18.686 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node3 | 3.797s | 2025-10-18 06:56:18.687 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 3.797s | 2025-10-18 06:56:18.687 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 3.797s | 2025-10-18 06:56:18.687 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.798s | 2025-10-18 06:56:18.688 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 3.798s | 2025-10-18 06:56:18.688 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.798s | 2025-10-18 06:56:18.688 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 3.798s | 2025-10-18 06:56:18.688 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.005s | 2025-10-18 06:56:18.895 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1056ms | |
| node1 | 4.020s | 2025-10-18 06:56:18.910 | 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 | 4.021s | 2025-10-18 06:56:18.911 | 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 | 4.059s | 2025-10-18 06:56:18.949 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 4.122s | 2025-10-18 06:56:19.012 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node1 | 4.123s | 2025-10-18 06:56:19.013 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 4.190s | 2025-10-18 06:56:19.080 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node2 | 4.267s | 2025-10-18 06:56:19.157 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node2 | 4.268s | 2025-10-18 06:56:19.158 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 4.269s | 2025-10-18 06:56:19.159 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 4.269s | 2025-10-18 06:56:19.159 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.269s | 2025-10-18 06:56:19.159 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 4.269s | 2025-10-18 06:56:19.159 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.270s | 2025-10-18 06:56:19.160 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 4.270s | 2025-10-18 06:56:19.160 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 4.308s | 2025-10-18 06:56:19.198 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node0 | 4.390s | 2025-10-18 06:56:19.280 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node0 | 4.391s | 2025-10-18 06:56:19.281 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 4.392s | 2025-10-18 06:56:19.282 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 4.392s | 2025-10-18 06:56:19.282 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 4.392s | 2025-10-18 06:56:19.282 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 4.392s | 2025-10-18 06:56:19.282 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 4.393s | 2025-10-18 06:56:19.283 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 4.393s | 2025-10-18 06:56:19.283 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.596s | 2025-10-18 06:56:19.486 | 50 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node3 | 4.601s | 2025-10-18 06:56:19.491 | 51 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node2 | 5.132s | 2025-10-18 06:56:20.022 | 50 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node2 | 5.139s | 2025-10-18 06:56:20.029 | 51 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 5.192s | 2025-10-18 06:56:20.082 | 50 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node0 | 5.198s | 2025-10-18 06:56:20.088 | 51 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node3 | 5.732s | 2025-10-18 06:56:20.622 | 52 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26300440] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=168630, randomLong=-5036984783409924652, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13440, randomLong=-1892977383188941378, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1316370, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms) | |||||||||
| node3 | 5.761s | 2025-10-18 06:56:20.651 | 53 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 5.769s | 2025-10-18 06:56:20.659 | 54 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node3 | 5.771s | 2025-10-18 06:56:20.661 | 55 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node3 | 5.850s | 2025-10-18 06:56:20.740 | 56 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "16125000000", "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": "IkYz9Q==", "port": 30124 }, { "ipAddressV4": "CoAAQA==", "port": 30124 }] }, { "nodeId": "1", "weight": "14625000000", "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": "Iqytbw==", "port": 30125 }, { "ipAddressV4": "CoAAOw==", "port": 30125 }] }, { "nodeId": "2", "weight": "2500000000", "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": "I+/9Zg==", "port": 30126 }, { "ipAddressV4": "CoAAPg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16750000000", "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": "IiqVyw==", "port": 30127 }, { "ipAddressV4": "CoAAOg==", "port": 30127 }] }] } | |||||||||
| node3 | 5.951s | 2025-10-18 06:56:20.841 | 57 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node3 | 5.952s | 2025-10-18 06:56:20.842 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node3 | 5.967s | 2025-10-18 06:56:20.857 | 59 | 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: 887fd6adeae3c3d743fca2a699139c5cda3a32cf4ac0365a5e84935339199267d9d293c39919f199e3f851ec4ff55d6f (root) PlatformTestingToolState / usual-clerk-photo-lunch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 6.165s | 2025-10-18 06:56:21.055 | 61 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node3 | 6.169s | 2025-10-18 06:56:21.059 | 62 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 6.173s | 2025-10-18 06:56:21.063 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 6.178s | 2025-10-18 06:56:21.068 | 63 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node3 | 6.178s | 2025-10-18 06:56:21.068 | 64 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node3 | 6.179s | 2025-10-18 06:56:21.069 | 65 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node3 | 6.179s | 2025-10-18 06:56:21.069 | 66 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node3 | 6.179s | 2025-10-18 06:56:21.069 | 67 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node3 | 6.180s | 2025-10-18 06:56:21.070 | 68 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node3 | 6.180s | 2025-10-18 06:56:21.070 | 69 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node3 | 6.180s | 2025-10-18 06:56:21.070 | 70 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node3 | 6.180s | 2025-10-18 06:56:21.070 | 71 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node3 | 6.181s | 2025-10-18 06:56:21.071 | 72 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node3 | 6.181s | 2025-10-18 06:56:21.071 | 73 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node3 | 6.181s | 2025-10-18 06:56:21.071 | 74 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node3 | 6.182s | 2025-10-18 06:56:21.072 | 75 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node3 | 6.182s | 2025-10-18 06:56:21.072 | 76 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node3 | 6.182s | 2025-10-18 06:56:21.072 | 77 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 6.199s | 2025-10-18 06:56:21.089 | 78 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | insertSeq = true | |
| node3 | 6.199s | 2025-10-18 06:56:21.089 | 79 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | appendSig = true | |
| node3 | 6.200s | 2025-10-18 06:56:21.090 | 80 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | variedSize = false | |
| node3 | 6.200s | 2025-10-18 06:56:21.090 | 81 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | payloadByteSize = 100 | |
| node3 | 6.200s | 2025-10-18 06:56:21.090 | 82 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | maxByteSize = 100 | |
| node3 | 6.201s | 2025-10-18 06:56:21.091 | 83 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node3 | 6.202s | 2025-10-18 06:56:21.092 | 84 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node3 | 6.203s | 2025-10-18 06:56:21.093 | 85 | INFO | DEMO_INFO | <<start-node-3>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 6.204s | 2025-10-18 06:56:21.094 | 86 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@61c2537f | |
| node3 | 6.205s | 2025-10-18 06:56:21.095 | 87 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node3 | 6.205s | 2025-10-18 06:56:21.095 | 88 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node3 | 6.212s | 2025-10-18 06:56:21.102 | 93 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@6fe09404, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@462bdcf8,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@5f05aa21,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@17c09604,snapshotInProgress=false] | |
| node3 | 6.221s | 2025-10-18 06:56:21.111 | 94 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node3 | 6.221s | 2025-10-18 06:56:21.111 | 95 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node3 | 6.226s | 2025-10-18 06:56:21.116 | 96 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 5202516911510287002 | |
| node3 | 6.226s | 2025-10-18 06:56:21.116 | 97 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 6.265s | 2025-10-18 06:56:21.155 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node1 | 6.266s | 2025-10-18 06:56:21.156 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 6.266s | 2025-10-18 06:56:21.156 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 6.266s | 2025-10-18 06:56:21.156 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 6.267s | 2025-10-18 06:56:21.157 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 6.267s | 2025-10-18 06:56:21.157 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 6.267s | 2025-10-18 06:56:21.157 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 6.268s | 2025-10-18 06:56:21.158 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 6.277s | 2025-10-18 06:56:21.167 | 52 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26366671] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=266950, randomLong=8155824510604376810, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=7650, randomLong=-9210299391568426082, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1530070, data=35, exception=null] OS Health Check Report - Complete (took 1026 ms) | |||||||||
| node3 | 6.302s | 2025-10-18 06:56:21.192 | 98 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | Starting platform 3 | |
| node3 | 6.304s | 2025-10-18 06:56:21.194 | 99 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node3 | 6.307s | 2025-10-18 06:56:21.197 | 100 | INFO | STARTUP | <<start-node-3>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node3 | 6.308s | 2025-10-18 06:56:21.198 | 101 | INFO | STARTUP | <<start-node-3>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node3 | 6.309s | 2025-10-18 06:56:21.199 | 102 | INFO | STARTUP | <<start-node-3>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 6.310s | 2025-10-18 06:56:21.200 | 53 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 6.311s | 2025-10-18 06:56:21.201 | 103 | WARN | STARTUP | <<start-node-3>> | PcesFileTracker: | No preconsensus event files available | |
| node3 | 6.312s | 2025-10-18 06:56:21.202 | 104 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node3 | 6.314s | 2025-10-18 06:56:21.204 | 105 | 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.315s | 2025-10-18 06:56:21.205 | 107 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | StatusStateMachine: | Platform spent 292.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node3 | 6.315s | 2025-10-18 06:56:21.205 | 106 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 starts transactions ........ | |
| node3 | 6.315s | 2025-10-18 06:56:21.205 | 108 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node3 | 6.319s | 2025-10-18 06:56:21.209 | 109 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | StatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node3 | 6.319s | 2025-10-18 06:56:21.209 | 110 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 6.320s | 2025-10-18 06:56:21.210 | 54 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node2 | 6.323s | 2025-10-18 06:56:21.213 | 55 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node0 | 6.336s | 2025-10-18 06:56:21.226 | 52 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26283945] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=173520, randomLong=1226736640346263624, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9440, randomLong=6138677300722862352, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1017360, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node0 | 6.374s | 2025-10-18 06:56:21.264 | 53 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node0 | 6.382s | 2025-10-18 06:56:21.272 | 54 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node0 | 6.384s | 2025-10-18 06:56:21.274 | 55 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node2 | 6.408s | 2025-10-18 06:56:21.298 | 56 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "16125000000", "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": "IkYz9Q==", "port": 30124 }, { "ipAddressV4": "CoAAQA==", "port": 30124 }] }, { "nodeId": "1", "weight": "14625000000", "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": "Iqytbw==", "port": 30125 }, { "ipAddressV4": "CoAAOw==", "port": 30125 }] }, { "nodeId": "2", "weight": "2500000000", "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": "I+/9Zg==", "port": 30126 }, { "ipAddressV4": "CoAAPg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16750000000", "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": "IiqVyw==", "port": 30127 }, { "ipAddressV4": "CoAAOg==", "port": 30127 }] }] } | |||||||||
| node0 | 6.461s | 2025-10-18 06:56:21.351 | 56 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "16125000000", "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": "IkYz9Q==", "port": 30124 }, { "ipAddressV4": "CoAAQA==", "port": 30124 }] }, { "nodeId": "1", "weight": "14625000000", "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": "Iqytbw==", "port": 30125 }, { "ipAddressV4": "CoAAOw==", "port": 30125 }] }, { "nodeId": "2", "weight": "2500000000", "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": "I+/9Zg==", "port": 30126 }, { "ipAddressV4": "CoAAPg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16750000000", "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": "IiqVyw==", "port": 30127 }, { "ipAddressV4": "CoAAOg==", "port": 30127 }] }] } | |||||||||
| node2 | 6.510s | 2025-10-18 06:56:21.400 | 57 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node2 | 6.511s | 2025-10-18 06:56:21.401 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node2 | 6.528s | 2025-10-18 06:56:21.418 | 59 | 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: 887fd6adeae3c3d743fca2a699139c5cda3a32cf4ac0365a5e84935339199267d9d293c39919f199e3f851ec4ff55d6f (root) PlatformTestingToolState / usual-clerk-photo-lunch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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.557s | 2025-10-18 06:56:21.447 | 57 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node0 | 6.558s | 2025-10-18 06:56:21.448 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node0 | 6.573s | 2025-10-18 06:56:21.463 | 59 | 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: 887fd6adeae3c3d743fca2a699139c5cda3a32cf4ac0365a5e84935339199267d9d293c39919f199e3f851ec4ff55d6f (root) PlatformTestingToolState / usual-clerk-photo-lunch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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.761s | 2025-10-18 06:56:21.651 | 61 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node2 | 6.766s | 2025-10-18 06:56:21.656 | 62 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node2 | 6.777s | 2025-10-18 06:56:21.667 | 63 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node2 | 6.778s | 2025-10-18 06:56:21.668 | 64 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 6.778s | 2025-10-18 06:56:21.668 | 65 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node2 | 6.778s | 2025-10-18 06:56:21.668 | 66 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node2 | 6.779s | 2025-10-18 06:56:21.669 | 67 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node2 | 6.779s | 2025-10-18 06:56:21.669 | 68 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node2 | 6.779s | 2025-10-18 06:56:21.669 | 69 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node2 | 6.780s | 2025-10-18 06:56:21.670 | 70 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node2 | 6.780s | 2025-10-18 06:56:21.670 | 71 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 6.780s | 2025-10-18 06:56:21.670 | 72 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node2 | 6.781s | 2025-10-18 06:56:21.671 | 73 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 6.781s | 2025-10-18 06:56:21.671 | 74 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node2 | 6.781s | 2025-10-18 06:56:21.671 | 75 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node2 | 6.781s | 2025-10-18 06:56:21.671 | 76 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node2 | 6.782s | 2025-10-18 06:56:21.672 | 77 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node0 | 6.789s | 2025-10-18 06:56:21.679 | 61 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node0 | 6.793s | 2025-10-18 06:56:21.683 | 62 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node2 | 6.799s | 2025-10-18 06:56:21.689 | 78 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | insertSeq = true | |
| node2 | 6.800s | 2025-10-18 06:56:21.690 | 79 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | appendSig = true | |
| node2 | 6.800s | 2025-10-18 06:56:21.690 | 80 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | variedSize = false | |
| node2 | 6.801s | 2025-10-18 06:56:21.691 | 81 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | payloadByteSize = 100 | |
| node2 | 6.801s | 2025-10-18 06:56:21.691 | 82 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | maxByteSize = 100 | |
| node2 | 6.801s | 2025-10-18 06:56:21.691 | 83 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 6.802s | 2025-10-18 06:56:21.692 | 63 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node0 | 6.802s | 2025-10-18 06:56:21.692 | 64 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 6.802s | 2025-10-18 06:56:21.692 | 84 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 6.803s | 2025-10-18 06:56:21.693 | 65 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node0 | 6.803s | 2025-10-18 06:56:21.693 | 66 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node0 | 6.803s | 2025-10-18 06:56:21.693 | 67 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node0 | 6.803s | 2025-10-18 06:56:21.693 | 68 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node0 | 6.804s | 2025-10-18 06:56:21.694 | 69 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node0 | 6.804s | 2025-10-18 06:56:21.694 | 70 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node0 | 6.804s | 2025-10-18 06:56:21.694 | 71 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 6.804s | 2025-10-18 06:56:21.694 | 85 | INFO | DEMO_INFO | <<start-node-2>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 6.805s | 2025-10-18 06:56:21.695 | 72 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node0 | 6.805s | 2025-10-18 06:56:21.695 | 73 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 6.805s | 2025-10-18 06:56:21.695 | 86 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@5e628eb9 | |
| node0 | 6.806s | 2025-10-18 06:56:21.696 | 74 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node0 | 6.806s | 2025-10-18 06:56:21.696 | 75 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node0 | 6.806s | 2025-10-18 06:56:21.696 | 76 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node0 | 6.807s | 2025-10-18 06:56:21.697 | 77 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node2 | 6.811s | 2025-10-18 06:56:21.701 | 87 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 6.811s | 2025-10-18 06:56:21.701 | 88 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 6.820s | 2025-10-18 06:56:21.710 | 93 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@71dfd707, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@cbb6703,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@6d7aa9be,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2177692e,snapshotInProgress=false] | |
| node0 | 6.823s | 2025-10-18 06:56:21.713 | 78 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | insertSeq = true | |
| node0 | 6.824s | 2025-10-18 06:56:21.714 | 79 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | appendSig = true | |
| node0 | 6.824s | 2025-10-18 06:56:21.714 | 80 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | variedSize = false | |
| node0 | 6.824s | 2025-10-18 06:56:21.714 | 81 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | payloadByteSize = 100 | |
| node0 | 6.825s | 2025-10-18 06:56:21.715 | 82 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | maxByteSize = 100 | |
| node0 | 6.825s | 2025-10-18 06:56:21.715 | 83 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 6.826s | 2025-10-18 06:56:21.716 | 84 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 6.827s | 2025-10-18 06:56:21.717 | 85 | INFO | DEMO_INFO | <<start-node-0>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 6.828s | 2025-10-18 06:56:21.718 | 86 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@39fe01bf | |
| node0 | 6.829s | 2025-10-18 06:56:21.719 | 87 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node0 | 6.829s | 2025-10-18 06:56:21.719 | 88 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 6.832s | 2025-10-18 06:56:21.722 | 94 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node2 | 6.832s | 2025-10-18 06:56:21.722 | 95 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 6.836s | 2025-10-18 06:56:21.726 | 93 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@6bed42ee, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@48fff818,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@649ceae7,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1c5c458e,snapshotInProgress=false] | |
| node2 | 6.840s | 2025-10-18 06:56:21.730 | 96 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 2995502693671570362 | |
| node2 | 6.840s | 2025-10-18 06:56:21.730 | 97 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 6.844s | 2025-10-18 06:56:21.734 | 94 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node0 | 6.845s | 2025-10-18 06:56:21.735 | 95 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 6.850s | 2025-10-18 06:56:21.740 | 96 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -4491123846297374472 | |
| node0 | 6.850s | 2025-10-18 06:56:21.740 | 97 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 6.931s | 2025-10-18 06:56:21.821 | 98 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | Starting platform 0 | |
| node2 | 6.932s | 2025-10-18 06:56:21.822 | 98 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | Starting platform 2 | |
| node0 | 6.933s | 2025-10-18 06:56:21.823 | 99 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node2 | 6.934s | 2025-10-18 06:56:21.824 | 99 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node0 | 6.936s | 2025-10-18 06:56:21.826 | 100 | INFO | STARTUP | <<start-node-0>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 6.937s | 2025-10-18 06:56:21.827 | 101 | INFO | STARTUP | <<start-node-0>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node2 | 6.937s | 2025-10-18 06:56:21.827 | 100 | INFO | STARTUP | <<start-node-2>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 6.938s | 2025-10-18 06:56:21.828 | 102 | INFO | STARTUP | <<start-node-0>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 6.938s | 2025-10-18 06:56:21.828 | 101 | INFO | STARTUP | <<start-node-2>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node2 | 6.939s | 2025-10-18 06:56:21.829 | 102 | INFO | STARTUP | <<start-node-2>> | InputWireChecks: | All input wires have been bound. | |
| node0 | 6.940s | 2025-10-18 06:56:21.830 | 103 | WARN | STARTUP | <<start-node-0>> | PcesFileTracker: | No preconsensus event files available | |
| node0 | 6.940s | 2025-10-18 06:56:21.830 | 104 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node2 | 6.941s | 2025-10-18 06:56:21.831 | 103 | WARN | STARTUP | <<start-node-2>> | PcesFileTracker: | No preconsensus event files available | |
| node2 | 6.941s | 2025-10-18 06:56:21.831 | 104 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node0 | 6.942s | 2025-10-18 06:56:21.832 | 105 | 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.943s | 2025-10-18 06:56:21.833 | 106 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 starts transactions ........ | |
| node2 | 6.943s | 2025-10-18 06:56:21.833 | 105 | 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. | |
| node0 | 6.944s | 2025-10-18 06:56:21.834 | 107 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | StatusStateMachine: | Platform spent 318.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node0 | 6.945s | 2025-10-18 06:56:21.835 | 108 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node2 | 6.945s | 2025-10-18 06:56:21.835 | 106 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 starts transactions ........ | |
| node2 | 6.946s | 2025-10-18 06:56:21.836 | 107 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | StatusStateMachine: | Platform spent 356.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node2 | 6.946s | 2025-10-18 06:56:21.836 | 108 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node0 | 6.950s | 2025-10-18 06:56:21.840 | 109 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | StatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node0 | 6.950s | 2025-10-18 06:56:21.840 | 110 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 6.951s | 2025-10-18 06:56:21.841 | 109 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | StatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node2 | 6.951s | 2025-10-18 06:56:21.841 | 110 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 7.123s | 2025-10-18 06:56:22.013 | 50 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node1 | 7.130s | 2025-10-18 06:56:22.020 | 51 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node1 | 8.255s | 2025-10-18 06:56:23.145 | 52 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26262216] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=168270, randomLong=3281721141203517297, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11109, randomLong=-2906213383229470495, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1080420, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms) | |||||||||
| node1 | 8.287s | 2025-10-18 06:56:23.177 | 53 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node1 | 8.296s | 2025-10-18 06:56:23.186 | 54 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node1 | 8.299s | 2025-10-18 06:56:23.189 | 55 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 8.386s | 2025-10-18 06:56:23.276 | 56 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "16125000000", "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": "IkYz9Q==", "port": 30124 }, { "ipAddressV4": "CoAAQA==", "port": 30124 }] }, { "nodeId": "1", "weight": "14625000000", "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": "Iqytbw==", "port": 30125 }, { "ipAddressV4": "CoAAOw==", "port": 30125 }] }, { "nodeId": "2", "weight": "2500000000", "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": "I+/9Zg==", "port": 30126 }, { "ipAddressV4": "CoAAPg==", "port": 30126 }] }, { "nodeId": "3", "weight": "16750000000", "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": "IiqVyw==", "port": 30127 }, { "ipAddressV4": "CoAAOg==", "port": 30127 }] }] } | |||||||||
| node1 | 8.501s | 2025-10-18 06:56:23.391 | 57 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node1 | 8.502s | 2025-10-18 06:56:23.392 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node1 | 8.522s | 2025-10-18 06:56:23.412 | 59 | 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: 887fd6adeae3c3d743fca2a699139c5cda3a32cf4ac0365a5e84935339199267d9d293c39919f199e3f851ec4ff55d6f (root) PlatformTestingToolState / usual-clerk-photo-lunch 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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 | 8.769s | 2025-10-18 06:56:23.659 | 61 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node1 | 8.774s | 2025-10-18 06:56:23.664 | 62 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 8.784s | 2025-10-18 06:56:23.674 | 63 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node1 | 8.785s | 2025-10-18 06:56:23.675 | 64 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node1 | 8.786s | 2025-10-18 06:56:23.676 | 65 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node1 | 8.786s | 2025-10-18 06:56:23.676 | 66 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node1 | 8.786s | 2025-10-18 06:56:23.676 | 67 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node1 | 8.787s | 2025-10-18 06:56:23.677 | 68 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node1 | 8.787s | 2025-10-18 06:56:23.677 | 69 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node1 | 8.788s | 2025-10-18 06:56:23.678 | 70 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node1 | 8.788s | 2025-10-18 06:56:23.678 | 71 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node1 | 8.788s | 2025-10-18 06:56:23.678 | 72 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node1 | 8.789s | 2025-10-18 06:56:23.679 | 73 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node1 | 8.789s | 2025-10-18 06:56:23.679 | 74 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node1 | 8.789s | 2025-10-18 06:56:23.679 | 75 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node1 | 8.789s | 2025-10-18 06:56:23.679 | 76 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node1 | 8.790s | 2025-10-18 06:56:23.680 | 77 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node1 | 8.807s | 2025-10-18 06:56:23.697 | 78 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | insertSeq = true | |
| node1 | 8.807s | 2025-10-18 06:56:23.697 | 79 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | appendSig = true | |
| node1 | 8.808s | 2025-10-18 06:56:23.698 | 80 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | variedSize = false | |
| node1 | 8.808s | 2025-10-18 06:56:23.698 | 81 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | payloadByteSize = 100 | |
| node1 | 8.809s | 2025-10-18 06:56:23.699 | 82 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | maxByteSize = 100 | |
| node1 | 8.809s | 2025-10-18 06:56:23.699 | 83 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node1 | 8.809s | 2025-10-18 06:56:23.699 | 84 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node1 | 8.811s | 2025-10-18 06:56:23.701 | 85 | INFO | DEMO_INFO | <<start-node-1>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node1 | 8.812s | 2025-10-18 06:56:23.702 | 86 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@749adc6a | |
| node1 | 8.813s | 2025-10-18 06:56:23.703 | 87 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node1 | 8.813s | 2025-10-18 06:56:23.703 | 88 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node1 | 8.820s | 2025-10-18 06:56:23.710 | 93 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@6d897197, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@50c20565,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@142dbbea,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@718f0de,snapshotInProgress=false] | |
| node1 | 8.830s | 2025-10-18 06:56:23.720 | 94 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node1 | 8.830s | 2025-10-18 06:56:23.720 | 95 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node1 | 8.836s | 2025-10-18 06:56:23.726 | 96 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -2567593250197329582 | |
| node1 | 8.836s | 2025-10-18 06:56:23.726 | 97 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 8.921s | 2025-10-18 06:56:23.811 | 98 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | Starting platform 1 | |
| node1 | 8.923s | 2025-10-18 06:56:23.813 | 99 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 8.926s | 2025-10-18 06:56:23.816 | 100 | INFO | STARTUP | <<start-node-1>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 8.928s | 2025-10-18 06:56:23.818 | 101 | INFO | STARTUP | <<start-node-1>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 8.928s | 2025-10-18 06:56:23.818 | 102 | INFO | STARTUP | <<start-node-1>> | InputWireChecks: | All input wires have been bound. | |
| node1 | 8.931s | 2025-10-18 06:56:23.821 | 103 | WARN | STARTUP | <<start-node-1>> | PcesFileTracker: | No preconsensus event files available | |
| node1 | 8.932s | 2025-10-18 06:56:23.822 | 104 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node1 | 8.934s | 2025-10-18 06:56:23.824 | 105 | INFO | STARTUP | <<start-node-1>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node1 | 8.935s | 2025-10-18 06:56:23.825 | 106 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 starts transactions ........ | |
| node1 | 8.935s | 2025-10-18 06:56:23.825 | 107 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | StatusStateMachine: | Platform spent 347.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 8.936s | 2025-10-18 06:56:23.826 | 108 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node1 | 8.940s | 2025-10-18 06:56:23.830 | 109 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | StatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node1 | 8.940s | 2025-10-18 06:56:23.830 | 110 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node3 | 9.186s | 2025-10-18 06:56:24.076 | 111 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ] | |
| node3 | 9.188s | 2025-10-18 06:56:24.078 | 112 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node2 | 9.786s | 2025-10-18 06:56:24.676 | 111 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ] | |
| node2 | 9.789s | 2025-10-18 06:56:24.679 | 112 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 9.811s | 2025-10-18 06:56:24.701 | 111 | 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.814s | 2025-10-18 06:56:24.704 | 112 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node1 | 11.795s | 2025-10-18 06:56:26.685 | 111 | 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 | 11.797s | 2025-10-18 06:56:26.687 | 112 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node3 | 16.410s | 2025-10-18 06:56:31.300 | 113 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | StatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node3 | 16.411s | 2025-10-18 06:56:31.301 | 114 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 17.039s | 2025-10-18 06:56:31.929 | 113 | INFO | PLATFORM_STATUS | <platformForkJoinThread-5> | StatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node2 | 17.040s | 2025-10-18 06:56:31.930 | 113 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | StatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node0 | 17.041s | 2025-10-18 06:56:31.931 | 114 | INFO | STARTUP | <platformForkJoinThread-5> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 17.041s | 2025-10-18 06:56:31.931 | 114 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 17.905s | 2025-10-18 06:56:32.795 | 115 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 17.906s | 2025-10-18 06:56:32.796 | 116 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | StatusStateMachine: | Platform spent 1.5 s in CHECKING. Now in ACTIVE | |
| node3 | 17.906s | 2025-10-18 06:56:32.796 | 117 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 17.916s | 2025-10-18 06:56:32.806 | 115 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node0 | 17.964s | 2025-10-18 06:56:32.854 | 115 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 17.971s | 2025-10-18 06:56:32.861 | 118 | TRACE | STARTUP | <<app: appMain 3>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x2666E3E233B67945049B945AA5AC4ED0F197097FFE3B6CB09B807CB998A52A0A', privateKey ='0x2666E3E233B67945049B945AA5AC4ED0F197097FFE3B6CB09B807CB998A52A0A', signature = '0xE0505690CAAB2641FBEF1948DA83277D50A2E3AEE9A5635020A44C25F0575FC5371BFCAB3E669E65EE0FF18ACCC1A1CE419A9C632CCF33E811F5A712E55CCD06',message = '0x12660A1A0803100318A03820A03828A03830A03840A6CEBDEFA385A3836B3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' } | |
| node1 | 18.038s | 2025-10-18 06:56:32.928 | 113 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.339s | 2025-10-18 06:56:33.229 | 116 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | StatusStateMachine: | Platform spent 1.3 s in CHECKING. Now in ACTIVE | |
| node2 | 18.340s | 2025-10-18 06:56:33.230 | 117 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 18.378s | 2025-10-18 06:56:33.268 | 118 | TRACE | STARTUP | <<app: appMain 2>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x1949A41C49400151700CB6A7F1517A8E688F21BAFF66C0D9FA01F52B6999D9E1', privateKey ='0x1949A41C49400151700CB6A7F1517A8E688F21BAFF66C0D9FA01F52B6999D9E1', signature = '0x7F2C2E8CC6A92BE31CA0CCE70718E58C193B777F6BE4DCDD42F420CC6DD16F0DCBCB73097DEE0D509289ECE334FEB2D5020B6CAD30B4BC455359FFEB6D267C0E',message = '0x12660A1A0802100218C02520C02528C02530C02540D786C7DCAEB1F8AC2C3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038024001' } | |
| node0 | 18.387s | 2025-10-18 06:56:33.277 | 116 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | StatusStateMachine: | Platform spent 1.3 s in CHECKING. Now in ACTIVE | |
| node0 | 18.388s | 2025-10-18 06:56:33.278 | 117 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node0 | 18.421s | 2025-10-18 06:56:33.311 | 118 | TRACE | STARTUP | <<app: appMain 0>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0xAEB04614780E3CF9FBBCEF9BDCF554E19E311A8146EE217CFCCD84E172A92F2B', privateKey ='0xAEB04614780E3CF9FBBCEF9BDCF554E19E311A8146EE217CFCCD84E172A92F2B', signature = '0xB7525F3E813774B248A7D64875D6ACD67F8897DDF08C783B87375830CDEB9BA98FE04201214C0CFFC260F2AA8994225221B824D6BC945FAE61713CCD60111108',message = '0x12660A0A40E0D8CDEAE9C9D8CC1D325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' } | |
| node3 | 18.771s | 2025-10-18 06:56:33.661 | 121 | 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 | 18.782s | 2025-10-18 06:56:33.672 | 121 | 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 | 18.830s | 2025-10-18 06:56:33.720 | 121 | 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 | 18.942s | 2025-10-18 06:56:33.832 | 116 | 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 | 19.031s | 2025-10-18 06:56:33.921 | 131 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | StatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node1 | 19.031s | 2025-10-18 06:56:33.921 | 132 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 19.136s | 2025-10-18 06:56:34.026 | 136 | 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 | 19.137s | 2025-10-18 06:56:34.027 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node1 | 19.173s | 2025-10-18 06:56:34.063 | 133 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 | |
| node1 | 19.176s | 2025-10-18 06:56:34.066 | 134 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node2 | 19.199s | 2025-10-18 06:56:34.089 | 136 | 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 | 19.201s | 2025-10-18 06:56:34.091 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node0 | 19.205s | 2025-10-18 06:56:34.095 | 136 | 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 | 19.207s | 2025-10-18 06:56:34.097 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node3 | 19.386s | 2025-10-18 06:56:34.276 | 191 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node3 | 19.389s | 2025-10-18 06:56:34.279 | 192 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-18T06:56:32.779545Z Next consensus number: 19 Legacy running event hash: 64f3cef6f8df7582b83170802274ea7da5ec11c9389299c70f8de3e727cf1e8b0e66877eedf688a347f88cd8bc2b0cd9 Legacy running event mnemonic: oyster-candy-tomorrow-raccoon Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 86d39116d2058a53d46e1ec7c9f31d76de9f2a602c8b58d2a969dfec38b7a415b46a10f1c3c2d47b98bda23732e817ae (root) PlatformTestingToolState / certain-tail-satoshi-remember 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 define-camera-crouch-decide 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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 | 19.422s | 2025-10-18 06:56:34.312 | 193 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/3/2025/10/18/2025-10-18T06+56+31.329330954Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 19.422s | 2025-10-18 06:56:34.312 | 194 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/3/2025/10/18/2025-10-18T06+56+31.329330954Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 19.422s | 2025-10-18 06:56:34.312 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node3 | 19.424s | 2025-10-18 06:56:34.314 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node3 | 19.429s | 2025-10-18 06:56:34.319 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node2 | 19.466s | 2025-10-18 06:56:34.356 | 191 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node2 | 19.469s | 2025-10-18 06:56:34.359 | 192 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-18T06:56:32.779545Z Next consensus number: 19 Legacy running event hash: 64f3cef6f8df7582b83170802274ea7da5ec11c9389299c70f8de3e727cf1e8b0e66877eedf688a347f88cd8bc2b0cd9 Legacy running event mnemonic: oyster-candy-tomorrow-raccoon Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 86d39116d2058a53d46e1ec7c9f31d76de9f2a602c8b58d2a969dfec38b7a415b46a10f1c3c2d47b98bda23732e817ae (root) PlatformTestingToolState / certain-tail-satoshi-remember 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 define-camera-crouch-decide 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 19.482s | 2025-10-18 06:56:34.372 | 191 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node0 | 19.487s | 2025-10-18 06:56:34.377 | 192 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-18T06:56:32.779545Z Next consensus number: 19 Legacy running event hash: 64f3cef6f8df7582b83170802274ea7da5ec11c9389299c70f8de3e727cf1e8b0e66877eedf688a347f88cd8bc2b0cd9 Legacy running event mnemonic: oyster-candy-tomorrow-raccoon Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 86d39116d2058a53d46e1ec7c9f31d76de9f2a602c8b58d2a969dfec38b7a415b46a10f1c3c2d47b98bda23732e817ae (root) PlatformTestingToolState / certain-tail-satoshi-remember 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 define-camera-crouch-decide 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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 | 19.501s | 2025-10-18 06:56:34.391 | 188 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for round 3 | |
| node2 | 19.505s | 2025-10-18 06:56:34.395 | 193 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/2/2025/10/18/2025-10-18T06+56+31.480389273Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 19.505s | 2025-10-18 06:56:34.395 | 194 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/2/2025/10/18/2025-10-18T06+56+31.480389273Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 19.505s | 2025-10-18 06:56:34.395 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node1 | 19.506s | 2025-10-18 06:56:34.396 | 189 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-18T06:56:32.779545Z Next consensus number: 19 Legacy running event hash: 64f3cef6f8df7582b83170802274ea7da5ec11c9389299c70f8de3e727cf1e8b0e66877eedf688a347f88cd8bc2b0cd9 Legacy running event mnemonic: oyster-candy-tomorrow-raccoon Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 86d39116d2058a53d46e1ec7c9f31d76de9f2a602c8b58d2a969dfec38b7a415b46a10f1c3c2d47b98bda23732e817ae (root) PlatformTestingToolState / certain-tail-satoshi-remember 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 define-camera-crouch-decide 1 SingletonNode RosterService.ROSTER_STATE /1 slogan-broken-home-sick 2 VirtualMap RosterService.ROSTERS /2 valid-balance-blanket-web 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 | 19.507s | 2025-10-18 06:56:34.397 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 19.511s | 2025-10-18 06:56:34.401 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node0 | 19.534s | 2025-10-18 06:56:34.424 | 193 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/0/2025/10/18/2025-10-18T06+56+31.487342523Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 19.535s | 2025-10-18 06:56:34.425 | 194 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/0/2025/10/18/2025-10-18T06+56+31.487342523Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 19.535s | 2025-10-18 06:56:34.425 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 19.537s | 2025-10-18 06:56:34.427 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 19.542s | 2025-10-18 06:56:34.432 | 190 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/1/2025/10/18/2025-10-18T06+56+31.424797437Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 19.543s | 2025-10-18 06:56:34.433 | 191 | 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/18/2025-10-18T06+56+31.424797437Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 19.543s | 2025-10-18 06:56:34.433 | 192 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 19.544s | 2025-10-18 06:56:34.434 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node1 | 19.544s | 2025-10-18 06:56:34.434 | 193 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 19.549s | 2025-10-18 06:56:34.439 | 194 | 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 | 20.499s | 2025-10-18 06:56:35.389 | 199 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | StatusStateMachine: | Platform spent 1.5 s in CHECKING. Now in ACTIVE | |
| node1 | 20.500s | 2025-10-18 06:56:35.390 | 200 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node1 | 20.517s | 2025-10-18 06:56:35.407 | 201 | TRACE | STARTUP | <<app: appMain 1>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x390F8D1695C282D76C31988E76727D02DB27C4A32CB7854B7C8CD0773D60D23D', privateKey ='0x390F8D1695C282D76C31988E76727D02DB27C4A32CB7854B7C8CD0773D60D23D', signature = '0xEA55B38E94EBD5198D47FED779F686664A4BD21B922A847D73E60113D863170C5AA13EB8C0C37C618247AEBA6C38B02E40FFF6E4CB7C0EFD4EC914E0E838190A',message = '0x1A6B0A1D0801100118BC3920DCC60628CC870130CC870140DBEBC5C7E5D7A4BA012A470000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00101' } | |
| node3 | 24.639s | 2025-10-18 06:56:39.529 | 278 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 24.640s | 2025-10-18 06:56:39.530 | 278 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 24.832s | 2025-10-18 06:56:39.722 | 278 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 26.207s | 2025-10-18 06:56:41.097 | 299 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 26.413s | 2025-10-18 06:56:41.303 | 299 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 26.536s | 2025-10-18 06:56:41.426 | 298 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 26.602s | 2025-10-18 06:56:41.492 | 301 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 28.009s | 2025-10-18 06:56:42.899 | 323 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 58.176s | 2025-10-18 06:57:13.066 | 784 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 58.202s | 2025-10-18 06:57:13.092 | 784 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 58.315s | 2025-10-18 06:57:13.205 | 800 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 59.714s | 2025-10-18 06:57:14.604 | 804 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 1m 21.477s | 2025-10-18 06:57:36.367 | 1141 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node3 | 1m 21.478s | 2025-10-18 06:57:36.368 | 1142 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node3 | 1m 21.481s | 2025-10-18 06:57:36.371 | 1143 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | node3 submits a transaction SAVE_EXPECTED_MAP | |
| node0 | 1m 22.578s | 2025-10-18 06:57:37.468 | 1161 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node2 | 1m 22.647s | 2025-10-18 06:57:37.537 | 1161 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 22.659s | 2025-10-18 06:57:37.549 | 1161 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node3 | 1m 22.725s | 2025-10-18 06:57:37.615 | 1164 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 22.922s | 2025-10-18 06:57:37.812 | 1162 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node0 | 1m 22.973s | 2025-10-18 06:57:37.863 | 1163 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node0 | 1m 22.974s | 2025-10-18 06:57:37.864 | 1164 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | node0 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 23.756s | 2025-10-18 06:57:38.646 | 1182 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node2 | 1m 23.807s | 2025-10-18 06:57:38.697 | 1183 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node2 | 1m 23.807s | 2025-10-18 06:57:38.697 | 1184 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | node2 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 24.391s | 2025-10-18 06:57:39.281 | 1185 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760770658142_142702579.json.gz | |
| node1 | 1m 24.392s | 2025-10-18 06:57:39.282 | 1182 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760770658142_142702579.json.gz | |
| node3 | 1m 24.471s | 2025-10-18 06:57:39.361 | 1185 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760770658142_142702579.json.gz | |
| node0 | 1m 24.580s | 2025-10-18 06:57:39.470 | 1185 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760770658142_142702579.json.gz | |
| node2 | 1m 24.685s | 2025-10-18 06:57:39.575 | 1186 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node1 | 1m 24.690s | 2025-10-18 06:57:39.580 | 1183 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 24.771s | 2025-10-18 06:57:39.661 | 1186 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node0 | 1m 24.902s | 2025-10-18 06:57:39.792 | 1186 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 25.766s | 2025-10-18 06:57:40.656 | 1207 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node1 | 1m 25.881s | 2025-10-18 06:57:40.771 | 1204 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node1 | 1m 25.909s | 2025-10-18 06:57:40.799 | 1205 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node1 | 1m 25.932s | 2025-10-18 06:57:40.822 | 1210 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node1 | 1m 25.932s | 2025-10-18 06:57:40.822 | 1211 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | node1 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 25.974s | 2025-10-18 06:57:40.864 | 1207 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node0 | 1m 25.977s | 2025-10-18 06:57:40.867 | 1207 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node3 | 1m 27.190s | 2025-10-18 06:57:42.080 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 27.278s | 2025-10-18 06:57:42.168 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node0 | 1m 27.280s | 2025-10-18 06:57:42.170 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 27.281s | 2025-10-18 06:57:42.171 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 29.304s | 2025-10-18 06:57:44.194 | 1269 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 29.579s | 2025-10-18 06:57:44.469 | 1269 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 1m 30.653s | 2025-10-18 06:57:45.543 | 1289 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 1m 30.765s | 2025-10-18 06:57:45.655 | 1290 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 1m 31.342s | 2025-10-18 06:57:46.232 | 1294 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 1m 31.389s | 2025-10-18 06:57:46.279 | 1293 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 1m 32.415s | 2025-10-18 06:57:47.305 | 1314 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 1m 33.205s | 2025-10-18 06:57:48.095 | 1330 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 2m 2.938s | 2025-10-18 06:58:17.828 | 1731 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 2m 2.939s | 2025-10-18 06:58:17.829 | 1732 | INFO | DEMO_INFO | <<app: appMain 2>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node2 | 2m 2.939s | 2025-10-18 06:58:17.829 | 1733 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Stop generating transactions | |
| node2 | 2m 2.942s | 2025-10-18 06:58:17.832 | 1734 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | node 2 sent ENTER_VALIDATION Message | |
| node2 | 2m 2.945s | 2025-10-18 06:58:17.835 | 1735 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 finished generating all transactions. | |
| node0 | 2m 3.617s | 2025-10-18 06:58:18.507 | 1751 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 2m 3.619s | 2025-10-18 06:58:18.509 | 1752 | INFO | DEMO_INFO | <<app: appMain 0>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node0 | 2m 3.619s | 2025-10-18 06:58:18.509 | 1753 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Stop generating transactions | |
| node0 | 2m 3.619s | 2025-10-18 06:58:18.509 | 1754 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | node 0 sent ENTER_VALIDATION Message | |
| node0 | 2m 3.622s | 2025-10-18 06:58:18.512 | 1755 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 finished generating all transactions. | |
| node3 | 2m 4.348s | 2025-10-18 06:58:19.238 | 1751 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.223545285Z ] | |
| node3 | 2m 4.350s | 2025-10-18 06:58:19.240 | 1752 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:18.223545285Z,type=ENTER_VALIDATION] | |
| node2 | 2m 4.551s | 2025-10-18 06:58:19.441 | 1756 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.223545285Z ] | |
| node2 | 2m 4.552s | 2025-10-18 06:58:19.442 | 1757 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:18.223545285Z,type=ENTER_VALIDATION] | |
| node1 | 2m 4.558s | 2025-10-18 06:58:19.448 | 1751 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.223545285Z ] | |
| node0 | 2m 4.559s | 2025-10-18 06:58:19.449 | 1756 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.223545285Z ] | |
| node0 | 2m 4.560s | 2025-10-18 06:58:19.450 | 1757 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:18.223545285Z,type=ENTER_VALIDATION] | |
| node1 | 2m 4.560s | 2025-10-18 06:58:19.450 | 1752 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:18.223545285Z,type=ENTER_VALIDATION] | |
| node3 | 2m 4.967s | 2025-10-18 06:58:19.857 | 1773 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.802939347Z ] | |
| node3 | 2m 4.968s | 2025-10-18 06:58:19.858 | 1774 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:18.802939347Z,type=ENTER_VALIDATION] | |
| node2 | 2m 4.998s | 2025-10-18 06:58:19.888 | 1778 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.802939347Z ] | |
| node2 | 2m 4.998s | 2025-10-18 06:58:19.888 | 1779 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:18.802939347Z,type=ENTER_VALIDATION] | |
| node1 | 2m 5.000s | 2025-10-18 06:58:19.890 | 1773 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.802939347Z ] | |
| node1 | 2m 5.001s | 2025-10-18 06:58:19.891 | 1774 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:18.802939347Z,type=ENTER_VALIDATION] | |
| node0 | 2m 5.018s | 2025-10-18 06:58:19.908 | 1762 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:18.802939347Z ] | |
| node0 | 2m 5.019s | 2025-10-18 06:58:19.909 | 1763 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:18.802939347Z,type=ENTER_VALIDATION] | |
| node1 | 2m 5.324s | 2025-10-18 06:58:20.214 | 1775 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 5.325s | 2025-10-18 06:58:20.215 | 1776 | INFO | DEMO_INFO | <<app: appMain 1>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node1 | 2m 5.325s | 2025-10-18 06:58:20.215 | 1777 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Stop generating transactions | |
| node1 | 2m 5.326s | 2025-10-18 06:58:20.216 | 1778 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | node 1 sent ENTER_VALIDATION Message | |
| node1 | 2m 5.326s | 2025-10-18 06:58:20.216 | 1779 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 finished generating all transactions. | |
| node3 | 2m 5.648s | 2025-10-18 06:58:20.538 | 1775 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 2m 5.649s | 2025-10-18 06:58:20.539 | 1776 | INFO | DEMO_INFO | <<app: appMain 3>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node3 | 2m 5.649s | 2025-10-18 06:58:20.539 | 1777 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Stop generating transactions | |
| node3 | 2m 5.649s | 2025-10-18 06:58:20.539 | 1778 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | node 3 sent ENTER_VALIDATION Message | |
| node3 | 2m 5.649s | 2025-10-18 06:58:20.539 | 1779 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 finished generating all transactions. | |
| node0 | 2m 6.936s | 2025-10-18 06:58:21.826 | 1800 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.529146956Z ] | |
| node0 | 2m 6.936s | 2025-10-18 06:58:21.826 | 1801 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:20.529146956Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.937s | 2025-10-18 06:58:21.827 | 1802 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.745318Z ] | |
| node0 | 2m 6.937s | 2025-10-18 06:58:21.827 | 1803 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:20.745318Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.938s | 2025-10-18 06:58:21.828 | 1804 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node0 | 2m 6.940s | 2025-10-18 06:58:21.830 | 1805 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 6.966s | 2025-10-18 06:58:21.856 | 1800 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.529146956Z ] | |
| node2 | 2m 6.966s | 2025-10-18 06:58:21.856 | 1801 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:20.529146956Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.967s | 2025-10-18 06:58:21.857 | 1806 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 0>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760770700745_745318000.json.gz | |
| node2 | 2m 6.967s | 2025-10-18 06:58:21.857 | 1802 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 6.967s | 2025-10-18 06:58:21.857 | 1803 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:20.745318Z,type=ENTER_VALIDATION] | |
| node2 | 2m 6.968s | 2025-10-18 06:58:21.858 | 1804 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 6.969s | 2025-10-18 06:58:21.859 | 1805 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node1 | 2m 6.977s | 2025-10-18 06:58:21.867 | 1800 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.529146956Z ] | |
| node1 | 2m 6.978s | 2025-10-18 06:58:21.868 | 1801 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:20.529146956Z,type=ENTER_VALIDATION] | |
| node1 | 2m 6.979s | 2025-10-18 06:58:21.869 | 1802 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.745318Z ] | |
| node1 | 2m 6.979s | 2025-10-18 06:58:21.869 | 1803 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:20.745318Z,type=ENTER_VALIDATION] | |
| node1 | 2m 6.980s | 2025-10-18 06:58:21.870 | 1804 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node1 | 2m 6.982s | 2025-10-18 06:58:21.872 | 1805 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 6.990s | 2025-10-18 06:58:21.880 | 1806 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 2>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760770700745_745318000.json.gz | |
| node1 | 2m 7.004s | 2025-10-18 06:58:21.894 | 1806 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 1>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760770700745_745318000.json.gz | |
| node3 | 2m 7.016s | 2025-10-18 06:58:21.906 | 1800 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.529146956Z ] | |
| node3 | 2m 7.016s | 2025-10-18 06:58:21.906 | 1801 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:20.529146956Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.017s | 2025-10-18 06:58:21.907 | 1802 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-18T06:58:20.745318Z ] | |
| node3 | 2m 7.017s | 2025-10-18 06:58:21.907 | 1803 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:20.745318Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.018s | 2025-10-18 06:58:21.908 | 1804 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node3 | 2m 7.020s | 2025-10-18 06:58:21.910 | 1805 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node3 | 2m 7.040s | 2025-10-18 06:58:21.930 | 1806 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 3>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760770700745_745318000.json.gz | |
| node0 | 2m 7.289s | 2025-10-18 06:58:22.179 | 1807 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node0 | 2m 7.289s | 2025-10-18 06:58:22.179 | 1808 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 7.297s | 2025-10-18 06:58:22.187 | 1807 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node2 | 2m 7.298s | 2025-10-18 06:58:22.188 | 1808 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node1 | 2m 7.303s | 2025-10-18 06:58:22.193 | 1807 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node1 | 2m 7.304s | 2025-10-18 06:58:22.194 | 1808 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node3 | 2m 7.345s | 2025-10-18 06:58:22.235 | 1807 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1760770700745_745318000.json, consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node3 | 2m 7.345s | 2025-10-18 06:58:22.235 | 1808 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:20.745318Z ] | |
| node0 | 2m 8.925s | 2025-10-18 06:58:23.815 | 1829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.438134Z ] | |
| node3 | 2m 8.925s | 2025-10-18 06:58:23.815 | 1829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.438134Z ] | |
| node3 | 2m 8.925s | 2025-10-18 06:58:23.815 | 1830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:22.438134Z,type=EXIT_VALIDATION] | |
| node3 | 2m 8.925s | 2025-10-18 06:58:23.815 | 1831 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.472530575Z ] | |
| node0 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:22.438134Z,type=EXIT_VALIDATION] | |
| node0 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1831 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.472530575Z ] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:22.472530575Z,type=EXIT_VALIDATION] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1833 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.480830Z ] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1834 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:22.480830Z,type=EXIT_VALIDATION] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1835 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1836 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:22.481029793Z,type=EXIT_VALIDATION] | |
| node3 | 2m 8.926s | 2025-10-18 06:58:23.816 | 1837 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:22.472530575Z,type=EXIT_VALIDATION] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1833 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.480830Z ] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1834 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:22.480830Z,type=EXIT_VALIDATION] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1835 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.481029793Z ] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1836 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:22.481029793Z,type=EXIT_VALIDATION] | |
| node0 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1837 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 2m 8.927s | 2025-10-18 06:58:23.817 | 1839 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 2m 8.928s | 2025-10-18 06:58:23.818 | 1841 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node0 | 2m 8.929s | 2025-10-18 06:58:23.819 | 1839 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 2m 8.930s | 2025-10-18 06:58:23.820 | 1844 | INFO | DEMO_INFO | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-18T06:58:22.481029793Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node0 | 2m 8.931s | 2025-10-18 06:58:23.821 | 1842 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Sending Freeze Transaction... | |
| node0 | 2m 8.931s | 2025-10-18 06:58:23.821 | 1843 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Finished Sending Freeze Transaction. | |
| node0 | 2m 8.931s | 2025-10-18 06:58:23.821 | 1844 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node0 | 2m 8.933s | 2025-10-18 06:58:23.823 | 1846 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-18T06:58:22.481029793Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 8.955s | 2025-10-18 06:58:23.845 | 1829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.438134Z ] | |
| node2 | 2m 8.956s | 2025-10-18 06:58:23.846 | 1830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:22.438134Z,type=EXIT_VALIDATION] | |
| node2 | 2m 8.956s | 2025-10-18 06:58:23.846 | 1831 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.472530575Z ] | |
| node2 | 2m 8.956s | 2025-10-18 06:58:23.846 | 1832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:22.472530575Z,type=EXIT_VALIDATION] | |
| node2 | 2m 8.957s | 2025-10-18 06:58:23.847 | 1833 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.480830Z ] | |
| node2 | 2m 8.957s | 2025-10-18 06:58:23.847 | 1834 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:22.480830Z,type=EXIT_VALIDATION] | |
| node2 | 2m 8.957s | 2025-10-18 06:58:23.847 | 1835 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.481029793Z ] | |
| node2 | 2m 8.957s | 2025-10-18 06:58:23.847 | 1836 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:22.481029793Z,type=EXIT_VALIDATION] | |
| node2 | 2m 8.957s | 2025-10-18 06:58:23.847 | 1837 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node2 | 2m 8.958s | 2025-10-18 06:58:23.848 | 1838 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node2 | 2m 8.958s | 2025-10-18 06:58:23.848 | 1841 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node2 | 2m 8.960s | 2025-10-18 06:58:23.850 | 1843 | INFO | DEMO_INFO | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-18T06:58:22.481029793Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 8.967s | 2025-10-18 06:58:23.857 | 1829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.438134Z ] | |
| node1 | 2m 8.967s | 2025-10-18 06:58:23.857 | 1830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-18T06:58:22.438134Z,type=EXIT_VALIDATION] | |
| node1 | 2m 8.968s | 2025-10-18 06:58:23.858 | 1831 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.472530575Z ] | |
| node1 | 2m 8.968s | 2025-10-18 06:58:23.858 | 1832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-18T06:58:22.472530575Z,type=EXIT_VALIDATION] | |
| node1 | 2m 8.968s | 2025-10-18 06:58:23.858 | 1833 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.480830Z ] | |
| node1 | 2m 8.969s | 2025-10-18 06:58:23.859 | 1834 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-18T06:58:22.480830Z,type=EXIT_VALIDATION] | |
| node1 | 2m 8.969s | 2025-10-18 06:58:23.859 | 1835 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-18T06:58:22.481029793Z ] | |
| node1 | 2m 8.969s | 2025-10-18 06:58:23.859 | 1836 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-18T06:58:22.481029793Z,type=EXIT_VALIDATION] | |
| node1 | 2m 8.969s | 2025-10-18 06:58:23.859 | 1837 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 2, type = EXIT_VALIDATION, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node1 | 2m 8.970s | 2025-10-18 06:58:23.860 | 1839 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node1 | 2m 8.971s | 2025-10-18 06:58:23.861 | 1841 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node1 | 2m 8.973s | 2025-10-18 06:58:23.863 | 1843 | INFO | DEMO_INFO | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-18T06:58:22.481029793Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 10.442s | 2025-10-18 06:58:25.332 | 1861 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760770763 | |
| node1 | 2m 10.456s | 2025-10-18 06:58:25.346 | 1861 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760770763 | |
| node3 | 2m 10.492s | 2025-10-18 06:58:25.382 | 1861 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760770763 | |
| node0 | 2m 10.597s | 2025-10-18 06:58:25.487 | 1863 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760770763 | |
| node2 | 2m 58.083s | 2025-10-18 06:59:12.973 | 2502 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 2 to 1>> | NetworkUtils: | Connection broken: 2 <- 1 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:12.969229461Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node2 | 2m 58.088s | 2025-10-18 06:59:12.978 | 2503 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 2 to 3>> | NetworkUtils: | Connection broken: 2 -> 3 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:12.974731739Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node2 | 2m 58.195s | 2025-10-18 06:59:13.085 | 2504 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 2 to 0>> | NetworkUtils: | Connection broken: 2 <- 0 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.080283589Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node0 | 2m 58.266s | 2025-10-18 06:59:13.156 | 2504 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 0 to 2>> | NetworkUtils: | Connection broken: 0 -> 2 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.152725222Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node1 | 2m 58.300s | 2025-10-18 06:59:13.190 | 2502 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 1 to 2>> | NetworkUtils: | Connection broken: 1 -> 2 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.185512591Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node3 | 2m 58.343s | 2025-10-18 06:59:13.233 | 2502 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 3 to 2>> | NetworkUtils: | Connection broken: 3 <- 2 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.229413883Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node3 | 2m 58.479s | 2025-10-18 06:59:13.369 | 2503 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 3 to 0>> | NetworkUtils: | Connection broken: 3 <- 0 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.364198475Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node3 | 2m 58.509s | 2025-10-18 06:59:13.399 | 2504 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 3 to 1>> | NetworkUtils: | Connection broken: 3 <- 1 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.395753880Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node0 | 2m 58.554s | 2025-10-18 06:59:13.444 | 2505 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 0 to 3>> | NetworkUtils: | Connection broken: 0 -> 3 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.439815021Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node1 | 2m 58.586s | 2025-10-18 06:59:13.476 | 2503 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 1 to 3>> | NetworkUtils: | Connection broken: 1 -> 3 | |
| com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-18T06:59:13.471676012Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) 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 com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:384) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 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.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:428) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more | |||||||||
| node2 | 3m 2.940s | 2025-10-18 06:59:17.830 | 2505 | INFO | PLATFORM_STATUS | <platformForkJoinThread-5> | StatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node2 | 3m 2.941s | 2025-10-18 06:59:17.831 | 2506 | INFO | STARTUP | <platformForkJoinThread-5> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 3.409s | 2025-10-18 06:59:18.299 | 2505 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | StatusStateMachine: | Platform spent 2.8 m in ACTIVE. Now in CHECKING | |
| node3 | 3m 3.410s | 2025-10-18 06:59:18.300 | 2506 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 3m 3.430s | 2025-10-18 06:59:18.320 | 2504 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | StatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node1 | 3m 3.431s | 2025-10-18 06:59:18.321 | 2505 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 3.439s | 2025-10-18 06:59:18.329 | 2506 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | StatusStateMachine: | Platform spent 2.8 m in ACTIVE. Now in CHECKING | |
| node0 | 3m 3.441s | 2025-10-18 06:59:18.331 | 2507 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 38.930s | 2025-10-18 06:59:53.820 | 2507 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 3m 38.932s | 2025-10-18 06:59:53.822 | 2508 | 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:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 3m 38.933s | 2025-10-18 06:59:53.823 | 2508 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node3 | 3m 38.934s | 2025-10-18 06:59:53.824 | 2509 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node3 | 3m 38.935s | 2025-10-18 06:59:53.825 | 2510 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node0 | 3m 38.938s | 2025-10-18 06:59:53.828 | 2509 | 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:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 3m 38.940s | 2025-10-18 06:59:53.830 | 2510 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node0 | 3m 38.942s | 2025-10-18 06:59:53.832 | 2511 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node2 | 3m 38.961s | 2025-10-18 06:59:53.851 | 2507 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node2 | 3m 38.963s | 2025-10-18 06:59:53.853 | 2508 | 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:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 3m 38.964s | 2025-10-18 06:59:53.854 | 2509 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node2 | 3m 38.965s | 2025-10-18 06:59:53.855 | 2510 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node1 | 3m 38.974s | 2025-10-18 06:59:53.864 | 2506 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-18T06:58:22.481029793Z ] | |
| node1 | 3m 38.976s | 2025-10-18 06:59:53.866 | 2507 | 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:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 3m 38.978s | 2025-10-18 06:59:53.868 | 2508 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node1 | 3m 38.979s | 2025-10-18 06:59:53.869 | 2509 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |